builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1505034345.34 results: success (0) revision: f8f481901e2d86dd5be8b8a9af1f81f67e1e9158 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.341760) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.342244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.342532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.360201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.360605) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-10 02:05:45-- 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% 46.2M=0s 2017-09-10 02:05:45 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.497944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.498291) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014892 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.548607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:45.548943) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8f481901e2d86dd5be8b8a9af1f81f67e1e9158 --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 f8f481901e2d86dd5be8b8a9af1f81f67e1e9158 --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=ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-10 02:05:45,636 truncating revision to first 12 chars 2017-09-10 02:05:45,636 Setting DEBUG logging. 2017-09-10 02:05:45,636 attempt 1/10 2017-09-10 02:05:45,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8f481901e2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-10 02:05:46,098 unpacking tar archive at: mozilla-central-f8f481901e2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758974 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:46.324490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:46.324845) ========= script_repo_revision: f8f481901e2d86dd5be8b8a9af1f81f67e1e9158 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:46.325261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:46.325558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 02:05:46.339317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-10 02:05:46.339718) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:46 INFO - MultiFileLogger online at 20170910 02:05:46 in /builds/slave/test 02:05:46 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 02:05:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:46 INFO - {'append_to_log': False, 02:05:46 INFO - 'base_work_dir': '/builds/slave/test', 02:05:46 INFO - 'blob_upload_branch': 'Firefox', 02:05:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:46 INFO - 'branch': 'Firefox', 02:05:46 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:46 INFO - 'code_coverage': False, 02:05:46 INFO - 'config_files': ('talos/linux_config.py',), 02:05:46 INFO - 'default_actions': ('clobber', 02:05:46 INFO - 'read-buildbot-config', 02:05:46 INFO - 'download-and-extract', 02:05:46 INFO - 'populate-webroot', 02:05:46 INFO - 'create-virtualenv', 02:05:46 INFO - 'install', 02:05:46 INFO - 'setup-mitmproxy', 02:05:46 INFO - 'run-tests'), 02:05:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:46 INFO - 'disable_ccov_upload': False, 02:05:46 INFO - 'disable_stylo': False, 02:05:46 INFO - 'download_minidump_stackwalk': True, 02:05:46 INFO - 'download_symbols': 'ondemand', 02:05:46 INFO - 'enable_stylo': False, 02:05:46 INFO - 'enable_webrender': False, 02:05:46 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:05:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:46 INFO - 'gecko_profile': False, 02:05:46 INFO - 'gecko_profile_interval': 0, 02:05:46 INFO - 'installer_path': 'installer.exe', 02:05:46 INFO - 'log_level': 'info', 02:05:46 INFO - 'log_name': 'talos', 02:05:46 INFO - 'log_to_console': True, 02:05:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:46 INFO - 'opt_config_files': (), 02:05:46 INFO - 'pip_index': False, 02:05:46 INFO - 'suite': 'dromaeojs-e10s', 02:05:46 INFO - 'system_bits': '32', 02:05:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:46 INFO - 'title': 'talos-linux64-ix-087', 02:05:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:46 INFO - 'use_talos_json': True, 02:05:46 INFO - 'verify': 'False', 02:05:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:46 INFO - 'work_dir': 'build'} 02:05:46 INFO - [mozharness: 2017-09-10 09:05:46.556423Z] Running clobber step. 02:05:46 INFO - Running pre-action listener: _resource_record_pre_action 02:05:46 INFO - Running main action method: clobber 02:05:46 INFO - rmtree: /builds/slave/test/build 02:05:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:47 INFO - Running post-action listener: _resource_record_post_action 02:05:47 INFO - [mozharness: 2017-09-10 09:05:47.681071Z] Finished clobber step (success) 02:05:47 INFO - [mozharness: 2017-09-10 09:05:47.681170Z] Running read-buildbot-config step. 02:05:47 INFO - Running pre-action listener: _resource_record_pre_action 02:05:47 INFO - Running main action method: read_buildbot_config 02:05:47 INFO - Using buildbot properties: 02:05:47 INFO - { 02:05:47 INFO - "project": "", 02:05:47 INFO - "product": "firefox", 02:05:47 INFO - "who": "archaeopteryx@coole-files.de", 02:05:47 INFO - "installer_path": "public/build/target.tar.bz2", 02:05:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:05:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:05:47 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:05:47 INFO - "stage_platform": "linux64-qr", 02:05:47 INFO - "basedir": "/builds/slave/test", 02:05:47 INFO - "buildnumber": 42, 02:05:47 INFO - "platform": "ubuntu64_hw_qr", 02:05:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:05:47 INFO - "slavebuilddir": "test", 02:05:47 INFO - "taskId": "bjmwLJFIQ5-sAVb9moTS3Q", 02:05:47 INFO - "branch": "mozilla-central", 02:05:47 INFO - "script_repo_revision": "production", 02:05:47 INFO - "revision": "f8f481901e2d86dd5be8b8a9af1f81f67e1e9158", 02:05:47 INFO - "slavename": "talos-linux64-ix-087", 02:05:47 INFO - "repo_path": "mozilla-central" 02:05:47 INFO - } 02:05:47 INFO - Finding installer, test and symbols from parent task. 02:05:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bjmwLJFIQ5-sAVb9moTS3Q'}, attempt #1 02:05:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bjmwLJFIQ5-sAVb9moTS3Q'}, attempt #1 02:05:48 INFO - Task dependencies: W1NZUJsyQSiI_HuWC54dMw 02:05:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw'}, attempt #1 02:05:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2 02:05:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.test_packages.json 02:05:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.crashreporter-symbols.zip 02:05:49 INFO - Running post-action listener: _resource_record_post_action 02:05:49 INFO - [mozharness: 2017-09-10 09:05:49.018985Z] Finished read-buildbot-config step (success) 02:05:49 INFO - [mozharness: 2017-09-10 09:05:49.019204Z] Running download-and-extract step. 02:05:49 INFO - Running pre-action listener: _resource_record_pre_action 02:05:49 INFO - Running main action method: download_and_extract 02:05:49 INFO - mkdir: /builds/slave/test/build/tests 02:05: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')]} 02:05:49 INFO - trying https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.test_packages.json 02:05:49 INFO - Downloading https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:05:49 INFO - Downloaded 989 bytes. 02:05:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:05:49 INFO - Using the following test package requirements: 02:05:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:05:49 INFO - u'common': [u'target.common.tests.zip'], 02:05:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:05:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:05:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:05:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:05:49 INFO - u'mozbase': [u'target.common.tests.zip'], 02:05:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:05:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:05:49 INFO - u'web-platform': [u'target.common.tests.zip', 02:05:49 INFO - u'target.web-platform.tests.tar.gz'], 02:05:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:05:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:05:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.common.tests.zip 02:05:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:05:49 INFO - Fetch https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.common.tests.zip into memory 02:05:50 INFO - Content-Length response header: 55024694 02:05:50 INFO - Bytes received: 55024694 02:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.talos.tests.zip 02:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.talos.tests.zip into memory 02:06:02 INFO - Content-Length response header: 14497963 02:06:02 INFO - Bytes received: 14497963 02:06: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')]} 02:06:02 INFO - trying https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2 02:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:06:03 INFO - Downloaded 62944091 bytes. 02:06:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2 02:06:04 INFO - mkdir: /builds/slave/test/properties 02:06:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:04 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:04 INFO - Contents: 02:06:04 INFO - build_url:https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2 02:06:04 INFO - Running post-action listener: _resource_record_post_action 02:06:04 INFO - Running post-action listener: find_tests_for_verification 02:06:04 INFO - Running post-action listener: set_extra_try_arguments 02:06:04 INFO - [mozharness: 2017-09-10 09:06:04.124316Z] Finished download-and-extract step (success) 02:06:04 INFO - [mozharness: 2017-09-10 09:06:04.124421Z] Running populate-webroot step. 02:06:04 INFO - Running pre-action listener: _resource_record_pre_action 02:06:04 INFO - Running main action method: populate_webroot 02:06:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:04 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['tresize', 02:06:04 INFO - 'tcanvasmark']}, 02:06:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:04 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['dromaeo_css', 02:06:04 INFO - 'kraken']}, 02:06:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:04 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'tests': ['damp', 'tps']}, 02:06:04 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['damp', 'tps']}, 02:06:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:04 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['dromaeo_dom']}, 02:06:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:06:04 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['basic_compositor_video', 02:06:04 INFO - 'glvideo']}, 02:06:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:06:04 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['ts_paint_webext', 02:06:04 INFO - 'tp5o_webext']}, 02:06:04 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:04 INFO - 'ts_paint', 02:06:04 INFO - 'tpaint', 02:06:04 INFO - 'sessionrestore', 02:06:04 INFO - 'sessionrestore_many_windows', 02:06:04 INFO - 'sessionrestore_no_auto_restore', 02:06:04 INFO - 'tabpaint']}, 02:06:04 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['a11yr', 02:06:04 INFO - 'ts_paint', 02:06:04 INFO - 'tpaint', 02:06:04 INFO - 'sessionrestore', 02:06:04 INFO - 'sessionrestore_many_windows', 02:06:04 INFO - 'sessionrestore_no_auto_restore', 02:06:04 INFO - 'tabpaint']}, 02:06:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:06:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:06:04 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['bloom_basic_singleton']}, 02:06:04 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['bloom_basic']}, 02:06:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:04 INFO - 'tsvgr_opacity', 02:06:04 INFO - 'tart', 02:06:04 INFO - 'tscrollx', 02:06:04 INFO - 'tsvg_static']}, 02:06:04 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['tsvgx', 02:06:04 INFO - 'tsvgr_opacity', 02:06:04 INFO - 'tart', 02:06:04 INFO - 'tscrollx', 02:06:04 INFO - 'tsvg_static']}, 02:06:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:06:04 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'talos_options': ['--disable-stylo'], 02:06:04 INFO - 'tests': ['tp5o']}, 02:06:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:06:04 INFO - 'talos_options': ['--mitmproxy', 02:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:06:04 INFO - '--firstNonBlankPaint'], 02:06:04 INFO - 'tests': ['tp6_google', 02:06:04 INFO - 'tp6_youtube', 02:06:04 INFO - 'tp6_amazon', 02:06:04 INFO - 'tp6_facebook']}, 02:06:04 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:06:04 INFO - 'talos_options': ['--disable-stylo', 02:06:04 INFO - '--mitmproxy', 02:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:06:04 INFO - '--firstNonBlankPaint'], 02:06:04 INFO - 'tests': ['tp6_google', 02:06:04 INFO - 'tp6_youtube', 02:06:04 INFO - 'tp6_amazon', 02:06:04 INFO - 'tp6_facebook']}, 02:06:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:06:04 INFO - 'talos_options': ['--stylo-threads=1', 02:06:04 INFO - '--mitmproxy', 02:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:06:04 INFO - '--firstNonBlankPaint'], 02:06:04 INFO - 'tests': ['tp6_google', 02:06:04 INFO - 'tp6_youtube', 02:06:04 INFO - 'tp6_amazon', 02:06:04 INFO - 'tp6_facebook']}, 02:06:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'talos_options': ['--xperf_path', 02:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:04 INFO - 'tests': ['tp5n']}, 02:06:04 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:06:04 INFO - 'talos_options': ['--disable-stylo', 02:06:04 INFO - '--xperf_path', 02:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:04 INFO - 'tests': ['tp5n']}}} 02:06:04 INFO - Running post-action listener: _resource_record_post_action 02:06:04 INFO - [mozharness: 2017-09-10 09:06:04.142306Z] Finished populate-webroot step (success) 02:06:04 INFO - [mozharness: 2017-09-10 09:06:04.142396Z] Running create-virtualenv step. 02:06:04 INFO - Running pre-action listener: _resource_record_pre_action 02:06:04 INFO - Running main action method: create_virtualenv 02:06:04 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:06:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:06:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:06:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:05 INFO - Installing pip...............done. 02:06:05 INFO - Return code: 0 02:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:06:05 INFO - Reading from file tmpfile_stdout 02:06:05 INFO - Output received: 02:06:05 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06: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')]} 02:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:05 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:05 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 02:06:05 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 02:06:05 INFO - Using env: {'DISPLAY': ':0', 02:06:05 INFO - 'HOME': '/home/cltbld', 02:06:05 INFO - 'LANG': 'en_US.UTF-8', 02:06:05 INFO - 'LANGUAGE': 'en_US:en', 02:06:05 INFO - 'LOGNAME': 'cltbld', 02:06:05 INFO - 'MAIL': '/var/mail/cltbld', 02:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:05 INFO - 'MOZ_NO_REMOTE': '1', 02:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:05 INFO - 'NO_EM_RESTART': '1', 02:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:05 INFO - 'PWD': '/builds/slave/test', 02:06:05 INFO - 'SHELL': '/bin/bash', 02:06:05 INFO - 'SHLVL': '1', 02:06:05 INFO - 'TERM': 'linux', 02:06:05 INFO - 'TMOUT': '86400', 02:06:05 INFO - 'USER': 'cltbld', 02:06:05 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:05 INFO - '_': '/tools/buildbot/bin/python'} 02:06:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:06:06 INFO - Downloading/unpacking pip>=1.5 02:06:06 INFO - Running setup.py egg_info for package pip 02:06:06 INFO - warning: no files found matching 'pip/cacert.pem' 02:06:06 INFO - warning: no files found matching '*.html' under directory 'docs' 02:06:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:06:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:06:06 INFO - Installing collected packages: pip 02:06:06 INFO - Found existing installation: pip 1.1 02:06:06 INFO - Uninstalling pip: 02:06:06 INFO - Successfully uninstalled pip 02:06:06 INFO - Running setup.py install for pip 02:06:06 INFO - warning: no files found matching 'pip/cacert.pem' 02:06:06 INFO - warning: no files found matching '*.html' under directory 'docs' 02:06:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:06:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:06:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:06:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:06:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:06:06 INFO - Successfully installed pip 02:06:06 INFO - Cleaning up... 02:06:06 INFO - Return code: 0 02:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:06:06 INFO - Using env: {'DISPLAY': ':0', 02:06:06 INFO - 'HOME': '/home/cltbld', 02:06:06 INFO - 'LANG': 'en_US.UTF-8', 02:06:06 INFO - 'LANGUAGE': 'en_US:en', 02:06:06 INFO - 'LOGNAME': 'cltbld', 02:06:06 INFO - 'MAIL': '/var/mail/cltbld', 02:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:06 INFO - 'MOZ_NO_REMOTE': '1', 02:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:06 INFO - 'NO_EM_RESTART': '1', 02:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:06 INFO - 'PWD': '/builds/slave/test', 02:06:06 INFO - 'SHELL': '/bin/bash', 02:06:06 INFO - 'SHLVL': '1', 02:06:06 INFO - 'TERM': 'linux', 02:06:06 INFO - 'TMOUT': '86400', 02:06:06 INFO - 'USER': 'cltbld', 02:06:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:06 INFO - '_': '/tools/buildbot/bin/python'} 02:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:06 INFO - Downloading/unpacking psutil>=3.1.1 02:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:07 INFO - Installing collected packages: psutil 02:06:07 INFO - Running setup.py install for psutil 02:06:07 INFO - building 'psutil._psutil_linux' extension 02:06:07 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 02:06:08 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 02:06:08 INFO - building 'psutil._psutil_posix' extension 02:06:08 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 02:06:08 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 02:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:08 INFO - Successfully installed psutil 02:06:08 INFO - Cleaning up... 02:06:08 INFO - Return code: 0 02:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06: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')]} 02:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:08 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:08 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 02:06:08 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 02:06:08 INFO - Using env: {'DISPLAY': ':0', 02:06:08 INFO - 'HOME': '/home/cltbld', 02:06:08 INFO - 'LANG': 'en_US.UTF-8', 02:06:08 INFO - 'LANGUAGE': 'en_US:en', 02:06:08 INFO - 'LOGNAME': 'cltbld', 02:06:08 INFO - 'MAIL': '/var/mail/cltbld', 02:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:08 INFO - 'MOZ_NO_REMOTE': '1', 02:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:08 INFO - 'NO_EM_RESTART': '1', 02:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:08 INFO - 'PWD': '/builds/slave/test', 02:06:08 INFO - 'SHELL': '/bin/bash', 02:06:08 INFO - 'SHLVL': '1', 02:06:08 INFO - 'TERM': 'linux', 02:06:08 INFO - 'TMOUT': '86400', 02:06:08 INFO - 'USER': 'cltbld', 02:06:08 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:08 INFO - '_': '/tools/buildbot/bin/python'} 02:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:06:09 INFO - Installing collected packages: mozsystemmonitor 02:06:09 INFO - Running setup.py install for mozsystemmonitor 02:06:09 INFO - Successfully installed mozsystemmonitor 02:06:09 INFO - Cleaning up... 02:06:10 INFO - Return code: 0 02:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:06:10 INFO - Using env: {'DISPLAY': ':0', 02:06:10 INFO - 'HOME': '/home/cltbld', 02:06:10 INFO - 'LANG': 'en_US.UTF-8', 02:06:10 INFO - 'LANGUAGE': 'en_US:en', 02:06:10 INFO - 'LOGNAME': 'cltbld', 02:06:10 INFO - 'MAIL': '/var/mail/cltbld', 02:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:10 INFO - 'MOZ_NO_REMOTE': '1', 02:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:10 INFO - 'NO_EM_RESTART': '1', 02:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:10 INFO - 'PWD': '/builds/slave/test', 02:06:10 INFO - 'SHELL': '/bin/bash', 02:06:10 INFO - 'SHLVL': '1', 02:06:10 INFO - 'TERM': 'linux', 02:06:10 INFO - 'TMOUT': '86400', 02:06:10 INFO - 'USER': 'cltbld', 02:06:10 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:10 INFO - '_': '/tools/buildbot/bin/python'} 02:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:10 INFO - Downloading/unpacking jsonschema==2.5.1 02:06:10 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 02:06:10 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 02:06:10 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 02:06:10 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 02:06:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:06:12 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 02:06:12 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 02:06:12 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 02:06:12 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 02:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:12 INFO - warning: no files found matching '*.txt' 02:06:12 INFO - no previously-included directories found matching 'build' 02:06:12 INFO - no previously-included directories found matching 'dist' 02:06:12 INFO - no previously-included directories found matching '.git*' 02:06:12 INFO - Installing collected packages: jsonschema, functools32 02:06:12 INFO - Running setup.py install for functools32 02:06:12 INFO - warning: no files found matching '*.txt' 02:06:12 INFO - no previously-included directories found matching 'build' 02:06:12 INFO - no previously-included directories found matching 'dist' 02:06:12 INFO - no previously-included directories found matching '.git*' 02:06:12 INFO - Successfully installed jsonschema functools32 02:06:12 INFO - Cleaning up... 02:06:12 INFO - Return code: 0 02:06:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:06:12 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')]} 02:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:12 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')]} 02:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:12 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:12 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 02:06:12 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 02:06:12 INFO - Using env: {'DISPLAY': ':0', 02:06:12 INFO - 'HOME': '/home/cltbld', 02:06:12 INFO - 'LANG': 'en_US.UTF-8', 02:06:12 INFO - 'LANGUAGE': 'en_US:en', 02:06:12 INFO - 'LOGNAME': 'cltbld', 02:06:12 INFO - 'MAIL': '/var/mail/cltbld', 02:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:12 INFO - 'MOZ_NO_REMOTE': '1', 02:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:12 INFO - 'NO_EM_RESTART': '1', 02:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:12 INFO - 'PWD': '/builds/slave/test', 02:06:12 INFO - 'SHELL': '/bin/bash', 02:06:12 INFO - 'SHLVL': '1', 02:06:12 INFO - 'TERM': 'linux', 02:06:12 INFO - 'TMOUT': '86400', 02:06:12 INFO - 'USER': 'cltbld', 02:06:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:12 INFO - '_': '/tools/buildbot/bin/python'} 02:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:06:13 INFO - Cleaning up... 02:06:13 INFO - Return code: 0 02:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:13 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')]} 02:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:13 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')]} 02:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:13 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:13 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 02:06:13 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 02:06:13 INFO - Using env: {'DISPLAY': ':0', 02:06:13 INFO - 'HOME': '/home/cltbld', 02:06:13 INFO - 'LANG': 'en_US.UTF-8', 02:06:13 INFO - 'LANGUAGE': 'en_US:en', 02:06:13 INFO - 'LOGNAME': 'cltbld', 02:06:13 INFO - 'MAIL': '/var/mail/cltbld', 02:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:13 INFO - 'MOZ_NO_REMOTE': '1', 02:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:13 INFO - 'NO_EM_RESTART': '1', 02:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:13 INFO - 'PWD': '/builds/slave/test', 02:06:13 INFO - 'SHELL': '/bin/bash', 02:06:13 INFO - 'SHLVL': '1', 02:06:13 INFO - 'TERM': 'linux', 02:06:13 INFO - 'TMOUT': '86400', 02:06:13 INFO - 'USER': 'cltbld', 02:06:13 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:13 INFO - '_': '/tools/buildbot/bin/python'} 02:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:13 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:13 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 02:06:13 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 02:06:13 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 02:06:13 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 02:06:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:14 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 02:06:14 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 02:06:14 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 02:06:14 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 02:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:15 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 02:06:15 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 02:06:15 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 02:06:15 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 02:06:15 INFO - Downloading docopt-0.6.1.tar.gz 02:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:15 INFO - Running setup.py install for blobuploader 02:06:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:15 INFO - Running setup.py install for requests 02:06:15 INFO - Running setup.py install for docopt 02:06:15 INFO - Successfully installed blobuploader requests docopt 02:06:15 INFO - Cleaning up... 02:06:15 INFO - Return code: 0 02:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:15 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')]} 02:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:15 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')]} 02:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:15 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:15 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 02:06:15 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 02:06:15 INFO - Using env: {'DISPLAY': ':0', 02:06:15 INFO - 'HOME': '/home/cltbld', 02:06:15 INFO - 'LANG': 'en_US.UTF-8', 02:06:15 INFO - 'LANGUAGE': 'en_US:en', 02:06:15 INFO - 'LOGNAME': 'cltbld', 02:06:15 INFO - 'MAIL': '/var/mail/cltbld', 02:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:15 INFO - 'MOZ_NO_REMOTE': '1', 02:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:15 INFO - 'NO_EM_RESTART': '1', 02:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:15 INFO - 'PWD': '/builds/slave/test', 02:06:15 INFO - 'SHELL': '/bin/bash', 02:06:15 INFO - 'SHLVL': '1', 02:06:15 INFO - 'TERM': 'linux', 02:06:15 INFO - 'TMOUT': '86400', 02:06:15 INFO - 'USER': 'cltbld', 02:06:15 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:15 INFO - '_': '/tools/buildbot/bin/python'} 02:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:16 INFO - Running setup.py (path:/tmp/pip-Od6aDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:16 INFO - Running setup.py (path:/tmp/pip-IS7AfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:16 INFO - Running setup.py (path:/tmp/pip-DOUKal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:16 INFO - Running setup.py (path:/tmp/pip-CynqY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:16 INFO - Running setup.py (path:/tmp/pip-hsd8RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:16 INFO - Running setup.py (path:/tmp/pip-56TfNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:16 INFO - Running setup.py (path:/tmp/pip-fldKJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:16 INFO - Running setup.py (path:/tmp/pip-PeW8NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:16 INFO - Running setup.py (path:/tmp/pip-EM7E6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:16 INFO - Running setup.py (path:/tmp/pip-t3ez5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:16 INFO - Running setup.py (path:/tmp/pip-aYBs9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:16 INFO - Running setup.py (path:/tmp/pip-EvV_MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:16 INFO - Running setup.py (path:/tmp/pip-sLe35t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:16 INFO - Running setup.py (path:/tmp/pip-KiDKTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:17 INFO - Running setup.py (path:/tmp/pip-1AH5yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:17 INFO - Running setup.py (path:/tmp/pip-9ZmnUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:17 INFO - Running setup.py (path:/tmp/pip-A8uERm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:17 INFO - Running setup.py install for manifestparser 02:06:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Running setup.py install for mozcrash 02:06:17 INFO - Running setup.py install for mozdebug 02:06:17 INFO - Running setup.py install for mozdevice 02:06:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Running setup.py install for mozfile 02:06:17 INFO - Running setup.py install for mozhttpd 02:06:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Running setup.py install for mozinfo 02:06:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Running setup.py install for mozInstall 02:06:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:17 INFO - Running setup.py install for mozleak 02:06:18 INFO - Running setup.py install for mozlog 02:06:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Running setup.py install for moznetwork 02:06:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Running setup.py install for mozprocess 02:06:18 INFO - Running setup.py install for mozprofile 02:06:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Running setup.py install for mozrunner 02:06:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Running setup.py install for mozscreenshot 02:06:18 INFO - Running setup.py install for moztest 02:06:18 INFO - Running setup.py install for mozversion 02:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:18 INFO - Cleaning up... 02:06:18 INFO - Return code: 0 02:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:18 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')]} 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:18 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')]} 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:18 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:18 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 02:06:18 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 02:06:18 INFO - Using env: {'DISPLAY': ':0', 02:06:18 INFO - 'HOME': '/home/cltbld', 02:06:18 INFO - 'LANG': 'en_US.UTF-8', 02:06:18 INFO - 'LANGUAGE': 'en_US:en', 02:06:18 INFO - 'LOGNAME': 'cltbld', 02:06:18 INFO - 'MAIL': '/var/mail/cltbld', 02:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:18 INFO - 'MOZ_NO_REMOTE': '1', 02:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:18 INFO - 'NO_EM_RESTART': '1', 02:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:18 INFO - 'PWD': '/builds/slave/test', 02:06:18 INFO - 'SHELL': '/bin/bash', 02:06:18 INFO - 'SHLVL': '1', 02:06:18 INFO - 'TERM': 'linux', 02:06:18 INFO - 'TMOUT': '86400', 02:06:18 INFO - 'USER': 'cltbld', 02:06:18 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:18 INFO - '_': '/tools/buildbot/bin/python'} 02:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:19 INFO - Running setup.py (path:/tmp/pip-ehgF9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:19 INFO - Running setup.py (path:/tmp/pip-8TinVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:19 INFO - Running setup.py (path:/tmp/pip-KtawSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:19 INFO - Running setup.py (path:/tmp/pip-xsG_Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:19 INFO - Running setup.py (path:/tmp/pip-DWujee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:19 INFO - Running setup.py (path:/tmp/pip-yfNcOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:19 INFO - Running setup.py (path:/tmp/pip-m8XN70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:19 INFO - Running setup.py (path:/tmp/pip-gaAqKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:19 INFO - Running setup.py (path:/tmp/pip-pU73pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:19 INFO - Running setup.py (path:/tmp/pip-9tL0tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:19 INFO - Running setup.py (path:/tmp/pip-_WuI7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:19 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)) 02:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:19 INFO - Running setup.py (path:/tmp/pip-ostTMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:20 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)) 02:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:20 INFO - Running setup.py (path:/tmp/pip-7VmLb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:20 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)) 02:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:20 INFO - Running setup.py (path:/tmp/pip-Jl3vLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:20 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)) 02:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:20 INFO - Running setup.py (path:/tmp/pip-3NSQor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:20 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)) 02:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:20 INFO - Running setup.py (path:/tmp/pip-vVbkaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:20 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)) 02:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:20 INFO - Running setup.py (path:/tmp/pip-ht68UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:20 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)) 02:06:20 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)) 02:06:20 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)) 02:06:20 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)) 02:06:20 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)) 02:06:20 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)) 02:06:20 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)) 02:06:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:20 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 02:06:20 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 02:06:20 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 02:06:20 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 02:06:21 INFO - Downloading blessings-1.6.tar.gz 02:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:21 INFO - Installing collected packages: blessings 02:06:21 INFO - Running setup.py install for blessings 02:06:21 INFO - Successfully installed blessings 02:06:21 INFO - Cleaning up... 02:06:21 INFO - Return code: 0 02:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:21 INFO - Reading from file tmpfile_stdout 02:06:21 INFO - Current package versions: 02:06:21 INFO - argparse == 1.2.1 02:06:21 INFO - blessings == 1.6 02:06:21 INFO - blobuploader == 1.2.4 02:06:21 INFO - docopt == 0.6.1 02:06:21 INFO - functools32 == 3.2.3-2 02:06:21 INFO - jsonschema == 2.5.1 02:06:21 INFO - manifestparser == 1.1 02:06:21 INFO - mozInstall == 1.13 02:06:21 INFO - mozcrash == 1.0 02:06:21 INFO - mozdebug == 0.1 02:06:21 INFO - mozdevice == 0.51 02:06:21 INFO - mozfile == 1.2 02:06:21 INFO - mozhttpd == 0.7 02:06:21 INFO - mozinfo == 0.10 02:06:21 INFO - mozleak == 0.1 02:06:21 INFO - mozlog == 3.5 02:06:21 INFO - moznetwork == 0.27 02:06:21 INFO - mozprocess == 0.25 02:06:21 INFO - mozprofile == 0.28 02:06:21 INFO - mozrunner == 6.13 02:06:21 INFO - mozscreenshot == 0.1 02:06:21 INFO - mozsystemmonitor == 0.3 02:06:21 INFO - moztest == 0.8 02:06:21 INFO - mozversion == 1.4 02:06:21 INFO - psutil == 3.1.1 02:06:21 INFO - requests == 1.2.3 02:06:21 INFO - wsgiref == 0.1.2 02:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:21 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:21 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 02:06:21 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 02:06:21 INFO - Using env: {'DISPLAY': ':0', 02:06:21 INFO - 'HOME': '/home/cltbld', 02:06:21 INFO - 'LANG': 'en_US.UTF-8', 02:06:21 INFO - 'LANGUAGE': 'en_US:en', 02:06:21 INFO - 'LOGNAME': 'cltbld', 02:06:21 INFO - 'MAIL': '/var/mail/cltbld', 02:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:21 INFO - 'MOZ_NO_REMOTE': '1', 02:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:21 INFO - 'NO_EM_RESTART': '1', 02:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:21 INFO - 'PWD': '/builds/slave/test', 02:06:21 INFO - 'SHELL': '/bin/bash', 02:06:21 INFO - 'SHLVL': '1', 02:06:21 INFO - 'TERM': 'linux', 02:06:21 INFO - 'TMOUT': '86400', 02:06:21 INFO - 'USER': 'cltbld', 02:06:21 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:21 INFO - '_': '/tools/buildbot/bin/python'} 02:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 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)) 02:06:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:06:22 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 02:06:22 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 02:06:22 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 02:06:22 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 02:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:06:23 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)) 02:06:23 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)) 02:06:23 INFO - Installing collected packages: simplejson 02:06:23 INFO - Running setup.py install for simplejson 02:06:23 INFO - building 'simplejson._speedups' extension 02:06:23 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 02:06:24 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 02:06:24 INFO - Successfully installed simplejson 02:06:24 INFO - Cleaning up... 02:06:24 INFO - Return code: 0 02:06:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:24 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 0x21321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', '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 02:06:24 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 02:06:24 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 02:06:24 INFO - Using env: {'DISPLAY': ':0', 02:06:24 INFO - 'HOME': '/home/cltbld', 02:06:24 INFO - 'LANG': 'en_US.UTF-8', 02:06:24 INFO - 'LANGUAGE': 'en_US:en', 02:06:24 INFO - 'LOGNAME': 'cltbld', 02:06:24 INFO - 'MAIL': '/var/mail/cltbld', 02:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:24 INFO - 'MOZ_NO_REMOTE': '1', 02:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:24 INFO - 'NO_EM_RESTART': '1', 02:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:24 INFO - 'PWD': '/builds/slave/test', 02:06:24 INFO - 'SHELL': '/bin/bash', 02:06:24 INFO - 'SHLVL': '1', 02:06:24 INFO - 'TERM': 'linux', 02:06:24 INFO - 'TMOUT': '86400', 02:06:24 INFO - 'USER': 'cltbld', 02:06:24 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:24 INFO - '_': '/tools/buildbot/bin/python'} 02:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:06:24 INFO - Cleaning up... 02:06:24 INFO - Return code: 0 02:06:24 INFO - Running post-action listener: _resource_record_post_action 02:06:24 INFO - Running post-action listener: _start_resource_monitoring 02:06:24 INFO - Starting resource monitoring. 02:06:24 INFO - [mozharness: 2017-09-10 09:06:24.810689Z] Finished create-virtualenv step (success) 02:06:24 INFO - [mozharness: 2017-09-10 09:06:24.811202Z] Running install step. 02:06:24 INFO - Running pre-action listener: _resource_record_pre_action 02:06:24 INFO - Running main action method: install 02:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:25 INFO - Reading from file tmpfile_stdout 02:06:25 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:25 INFO - Reading from file tmpfile_stdout 02:06:25 INFO - Output received: 02:06:25 INFO - Usage: mozinstall [options] installer 02:06:25 INFO - Options: 02:06:25 INFO - -h, --help show this help message and exit 02:06:25 INFO - -d DEST, --destination=DEST 02:06:25 INFO - Directory to install application into. [default: 02:06:25 INFO - "/builds/slave/test"] 02:06:25 INFO - --app=APP Application being installed. [default: firefox] 02:06:25 INFO - mkdir: /builds/slave/test/build/application 02:06:25 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'] 02:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:06:41 INFO - Reading from file tmpfile_stdout 02:06:41 INFO - Output received: 02:06:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:06:41 INFO - Running post-action listener: _resource_record_post_action 02:06:41 INFO - [mozharness: 2017-09-10 09:06:41.733049Z] Finished install step (success) 02:06:41 INFO - [mozharness: 2017-09-10 09:06:41.733304Z] Running setup-mitmproxy step. 02:06:41 INFO - Running pre-action listener: _resource_record_pre_action 02:06:41 INFO - Running main action method: setup_mitmproxy 02:06:41 INFO - Skipping: mitmproxy is not required 02:06:41 INFO - Running post-action listener: _resource_record_post_action 02:06:41 INFO - [mozharness: 2017-09-10 09:06:41.734491Z] Finished setup-mitmproxy step (success) 02:06:41 INFO - [mozharness: 2017-09-10 09:06:41.734713Z] Running run-tests step. 02:06:41 INFO - Running pre-action listener: _resource_record_pre_action 02:06:41 INFO - Running pre-action listener: _set_gcov_prefix 02:06:41 INFO - Running main action method: run_tests 02:06:41 WARNING - Try message not found. 02:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:41 INFO - Python 2.7.3 02:06:41 INFO - Return code: 0 02:06:41 INFO - grabbing minidump binary from tooltool 02:06:41 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')]} 02:06:41 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 0x24a2090>, '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 0x24a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:41 INFO - Return code: 0 02:06:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:06:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:41 INFO - ENV: RUST_BACKTRACE is now full 02:06:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:06:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:41 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/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 02:06:41 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/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 02:06:41 INFO - Using env: {'DISPLAY': ':0', 02:06:41 INFO - 'HOME': '/home/cltbld', 02:06:41 INFO - 'LANG': 'en_US.UTF-8', 02:06:41 INFO - 'LANGUAGE': 'en_US:en', 02:06:41 INFO - 'LOGNAME': 'cltbld', 02:06:41 INFO - 'MAIL': '/var/mail/cltbld', 02:06:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:41 INFO - 'MOZ_ACCELERATED': '1', 02:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:41 INFO - 'MOZ_NO_REMOTE': '1', 02:06:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:41 INFO - 'MOZ_WEBRENDER': '1', 02:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:41 INFO - 'NO_EM_RESTART': '1', 02:06:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:41 INFO - 'PWD': '/builds/slave/test', 02:06:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:41 INFO - 'RUST_BACKTRACE': 'full', 02:06:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:06:41 INFO - 'SHELL': '/bin/bash', 02:06:41 INFO - 'SHLVL': '1', 02:06:41 INFO - 'TERM': 'linux', 02:06:41 INFO - 'TMOUT': '86400', 02:06:41 INFO - 'USER': 'cltbld', 02:06:41 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:41 INFO - '_': '/tools/buildbot/bin/python'} 02:06:41 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/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 02:06:42 INFO - mozversion application_buildid: 20170910080600 02:06:42 INFO - mozversion application_changeset: f8f481901e2d86dd5be8b8a9af1f81f67e1e9158 02:06:42 INFO - mozversion application_display_name: Nightly 02:06:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:42 INFO - mozversion application_name: Firefox 02:06:42 INFO - mozversion application_remotingname: firefox 02:06:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:06:42 INFO - mozversion application_vendor: Mozilla 02:06:42 INFO - mozversion application_version: 57.0a1 02:06:42 INFO - mozversion platform_buildid: 20170910080600 02:06:42 INFO - mozversion platform_changeset: f8f481901e2d86dd5be8b8a9af1f81f67e1e9158 02:06:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:06:42 INFO - mozversion platform_version: 57.0a1 02:06:42 INFO - using testdate: 1505034402 02:06:42 INFO - actual date: 1505034402 02:06:42 INFO - starting webserver on 'localhost:35123' 02:06:42 INFO - SUITE-START | Running 2 tests 02:06:42 INFO - TEST-START | dromaeo_css 02:06:42 INFO - Initialising browser for dromaeo_css test... 02:06:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35123/getInfo.html -profile /tmp/tmpjSiYir/profile 02:06:42 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/firefox/firefox http://localhost:35123/getInfo.html) 02:06:50 INFO - TEST-INFO | 1638: exit 0 02:06:50 INFO - Browser initialized. 02:06:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:50 INFO - Using env: {'DISPLAY': ':0', 02:06:50 INFO - 'HOME': '/home/cltbld', 02:06:50 INFO - 'JSGC_DISABLE_POISONING': '1', 02:06:50 INFO - 'LANG': 'en_US.UTF-8', 02:06:50 INFO - 'LANGUAGE': 'en_US:en', 02:06:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:06:50 INFO - 'LOGNAME': 'cltbld', 02:06:50 INFO - 'MAIL': '/var/mail/cltbld', 02:06:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:50 INFO - 'MOZ_ACCELERATED': '1', 02:06:50 INFO - 'MOZ_CRASHREPORTER': '1', 02:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:06:50 INFO - 'MOZ_NO_REMOTE': '1', 02:06:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:50 INFO - 'MOZ_WEBRENDER': '1', 02:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:50 INFO - 'NO_EM_RESTART': '1', 02:06:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:50 INFO - 'PWD': '/builds/slave/test', 02:06:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:50 INFO - 'RUST_BACKTRACE': 'full', 02:06:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:06:50 INFO - 'SHELL': '/bin/bash', 02:06:50 INFO - 'SHLVL': '1', 02:06:50 INFO - 'TERM': 'linux', 02:06:50 INFO - 'TMOUT': '86400', 02:06:50 INFO - 'USER': 'cltbld', 02:06:50 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:50 INFO - '_': '/tools/buildbot/bin/python'} 02:06:50 INFO - TEST-INFO | started process 1850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjSiYir/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:51 INFO - PID 1850 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:06:51 INFO - PID 1850 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:06:51 INFO - PID 1850 | 02:06:51 INFO - PID 1850 | (/builds/slave/test/build/application/firefox/firefox:1910): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:06:51 INFO - PID 1850 | 02:07:02 INFO - PID 1850 | RSS: Main: 207994880 02:07:02 INFO - PID 1850 | 02:09:59 INFO - PID 1850 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35123/tests/dromaeo/cssquery-ext.html) 02:10:00 INFO - PID 1850 | RSS: Main: 217739264 02:10:00 INFO - PID 1850 | 02:13:02 INFO - PID 1850 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-ext.html (next: http://localhost:35123/tests/dromaeo/cssquery-jquery.html) 02:13:02 INFO - PID 1850 | RSS: Main: 217325568 02:13:02 INFO - PID 1850 | 02:16:05 INFO - PID 1850 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35123/tests/dromaeo/cssquery-mootools.html) 02:16:05 INFO - PID 1850 | RSS: Main: 220381184 02:16:05 INFO - PID 1850 | 02:19:07 INFO - PID 1850 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35123/tests/dromaeo/cssquery-prototype.html) 02:19:08 INFO - PID 1850 | RSS: Main: 217899008 02:19:08 INFO - PID 1850 | 02:22:12 INFO - PID 1850 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35123/tests/dromaeo/cssquery-yui.html) 02:22:12 INFO - PID 1850 | RSS: Main: 220217344 02:22:12 INFO - PID 1850 | 02:25:14 INFO - PID 1850 | Cycle 1(1): loaded http://localhost:35123/tests/dromaeo/cssquery-yui.html (next: http://localhost:35123/tests/dromaeo/cssquery-dojo.html) 02:25:15 INFO - PID 1850 | RSS: Main: 223211520 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | __start_tp_report 02:25:15 INFO - PID 1850 | _x_x_mozilla_page_load 02:25:15 INFO - PID 1850 | _x_x_mozilla_page_load_details 02:25:15 INFO - PID 1850 | |i|pagename|runs| 02:25:15 INFO - PID 1850 | |0;dojo.html;3059.0975662179662;3091.7681173911933;3099.5505651680505;3123.39093876694;3136.2002689314236;6211.31675515694;6235.563510554269;6283.591566548172;6284.905726414102;6303.401176888194;6154.015357542794;6158.938410615892;6176.567640265183;6191.721372538235;6225.844353891155;5696.715164241771;5707.77168913243;5751.10857817037;5754.079347304432;5795.971020144893;5768.509676677488;5823.475887170154;5829.766809327622;5841.678707671076;5881.294244690622;5786.56600754943;5802.883942321151;5862.50168735658;5871.119332100197;5881.941180588182;474.46171553112157;5605.607607467479;5662.178984047331;5801.216835727165;5822.621529600562;5669.291338582677;5708.286464191976;5724.484796368305;5788.218590490272;5794.68129252891;6216.067589861512;6242.1261023456755;6244.3755624437645;6244.906326405107;6301.023341382093;6651.401373876326;6660.633665148415;6662.966685166543;6750.594964302109;6756.8310792230095;6654.26803051664;6713.429358504533;6740;6816.113905192343;6816.897746533806;6072.210612620331;6180.412860778219;6202.162708034402;6233.688315584202;6273.749050037993;6870.7595234166565;6924.688389022405;6929.237783843773;6933.0293758873795;6963.9303606964295;6557;6589.670516474157;6643.534952553275;6645.06969024337;6648.434883034899;6682.966585167141;6706.93293067063;6727.192736871607;6807.625580593115;6821.965890170617;6476.935230647728;6587.110740050128;6609.933900661028;6621.702023408958;6704.698288577026;6578.835529111715;6588.901166482507;6605.339466053356;6615.404613584704;6617.933820661828;5192.299039629602;5215.374155101412;5297.258383826267;5297.682139071668;5298.470152984671;4500.077484115748;4536.206163921301;4548.317752337176;4554.27131658933;4669.556392142741;5736.42635736423;5773.3072031356505;5807.622504537191;5810.041343178328;5815.912761308584;6633.834154146089;6676.6661666917435;6724.529282950147;6770.052192693027;6798.422134118655;5587.1339942309005;5694.800681976111;5706.71466426677;5781.103928891029;5798.88402231953;5685.6304340218585;5715.599908006483;5791.7683292667825;5795.7391917362975;5797.855053623609;6471.741130354733;6488.545801793829;6488.578242414228;6520.5435619507125;6538.215414150332;6583.868322633616;6660.400563949268;6695.096162018065;6768.390844823989;6768.898466523006;6400.39196276353;6444.033394990789;6489.772857949949;6513.609183449008;6515.446187074152;6426.357364263723;6520.217573891164;6553.541252112306;6610.900836487361;6628.204615445984;6658.966705166443;6690.665466726547;6752.3922846944015;6759.493038022069;6761.0534525167495;6414.903776443264;6429.903551446639;6470.158879345655;6518.445932095825;6525.9021114684265;6419.967900160469;6457.063725759833;6462.676866156579;6508.739650413931;6527.314631963765;6271.216097987752;6375.362463753588;6396.520260980352;6459.741610335534;6485.448736857231;6511.544191906521;6532.706028228646;6564.409203171737;6591.143151390289;6601.966990165019;6240.594361366497;6250.656213908279;6293.213348331458;6331.746730130743;6350.301466838551 02:25:15 INFO - PID 1850 | |1;ext.html;843.4475418600819;867.3841572483536;892.9910700892989;895.1138373010717;897.0177655467261;38675;39383.409248861215;39423.802880985626;39816;39820.60179398209;38259.617403825956;39368.409473857915;39459.802700986525;39597.40603890944;39671.206575868535;7642.541447513153;7684.500507467024;7717.459777815555;7719;7728.033995750531;7640.961795191016;7725.343345815584;7767.067951845786;7773.378129749606;7781.844363112763;7735.033120859893;7742.380609551223;7754.651040703182;7772.805679857992;7803.02462192226;7693.192214817447;7711.537307761552;7726.266004729542;7754.302112809818;7774.455788094864;7633.0458692663415;7681.692732290701;7694.538327700356;7699.345555627779;7699.653515591812;36658;36796;36987.81506092479;37021.259574808624;37021.81489092537;3568.8750893718857;3599.2621512590117;3602.3155600436094;3603.4234522476277;3604.567451905762;30829.845850770827;30848.38303233923;30873;30879.228019299473;30925.381492370027;5149.922751158736;5190.7404629768735;5190.818321358772;5212.218167274901;5245.26566280721;177050;177747;178581;178642;179293;45648.54351456509;45743.77128114338;45866.08267834625;45901.31148032782;46005.76997114993;50677.493225068014;51423.22865157026;51534.74232628813;51615.48384516107;51744.741276293375;15777.447789327318;15968.840311596967;15992.76010859838;16104.919475402548;16121.919390403207;13035.087543871838;13115.934420328029;13117.803232951514;13251.13867598603;13292.3353832308;13963.511277105252;14030.088044277089;14063;14102.71794564103;14105.717885642229;5777.8555536111935;5828.708564571754;5966.761329546856;5995.850103747442;6010.66941318223;997.5660587644253;1001.7295330260789;1009.9697009089739;1017.5370206555999;1030.5877648940484;22501.32496025122;22513.531207988362;22573.20993765243;22806.201782937518;23005.309840704806;1089.1885545268826;1100.873399559061;1110.6501452042742;1112.4660163121746;1125.4035361258545;11915.404229788475;12027.458764355624;12088.939555302168;12131.818022729665;12132.15074944763;208603;211913;212467;213532;213902;43298;44181.77909110434;49818;50344.49655503471;55099.72450137723;1402.4810819996667;1432.792245124472;1454.6436123149685;1466.047069404874;1469.4122351059661;27173;27227.86386068057;27496.450070998868;27517.174484765488;27850.303742406602;33551.496727549595;33649.15877103092;33680.49479257764;33764.3247135051;33847.153821154665;191006;191113;191623;191914;192675;33400;34011.31977360389;34608.48087278743;34616.48075278822;34633.65366346304;39996.2001709918;41368;41584;41629.58370416257;41783.373249400676;30468.23829404194;31045.379092417574;31100.68899310978;31279;31422.70061643586;31076.993721113955;31164.220894477818;31224.37551248917;31261;31283.37433251368;35057.298854022265;35092.298154037286;35325;35450.468242976895;35547.64452355547;30222.697773021988;31009.604567794955;31135.221619459695;31158.532622011142;31784.04647860568;22168.445788854762;23003.07987680474;23060.308190754306;23397.181098661466;23468.94389752431 02:25:15 INFO - PID 1850 | |2;jquery.html;560.48155456203;572.5791543215736;573.2204202284894;580.8780156167205;581.0876923230528;22158.113675452983;22732.54534909303;23117.884410577964;23222.65166022511;23306.533869322604;23429.76570234297;24416.75583244167;24533.509329813394;24888.626670599955;25020.87489562554;6368.458681012119;6527.510436717242;6546.672666366687;6550.8689826203445;6576.342365763433;6356.237251529823;6451.645159516224;6485.546011779177;6504.609723416586;6506.512011599125;6149.784757533487;6433.581817181892;6440.420362167404;6444.581102228363;6447.5809072410375;6440.162778838744;6479.514036447262;6483.578567393104;6491.8701625967215;6493.772717954873;5960.523158147381;5962.165296858443;5992.310884248323;6016.819495415145;6542.855000374915;29379.265518361997;30184.54723179154;30213.546796798066;30237.69762302371;30248.697513024807;2048.8873111978837;2073;2082.37528741377;2091.4039498742786;2092.6442504774227;19922.80077199224;20213.494662633406;20459.795402045936;20576.485587860272;21164.470888227763;2453.8895749691305;2521.2184222890965;2524.5960646296503;2530.860802655853;2537.6574162488196;123881;129616.35191824075;138469.3076534611;144289;144378.27810860984;19906.90046549787;20053.197872084955;20300.492487687632;20745.273915412887;21569.460763480725;41006.794966025576;41009.794951025055;41268;41387.37918931218;41563.376549351786;11195.832062519068;11292.153088518395;11436.256643318158;11594.18840681161;11613.245139065933;9517.476538790434;9672.371295865747;9697.127258546765;9708.902910970799;9881.604735810632;10577.57689692419;10607.893921060844;11216.102711783202;11306.095512358992;11413.771724565462;3660.4692319613505;3920.4119382092913;4057.208844275397;4062.614051665087;4137.8758637240935;958.7363475044418;959.8464245720651;969.132626299458;975.2685485885586;981.1365997921926;18330.816691833177;18412.4508951332;18810.059497025093;18862.056897155362;19109.33117340914;1005.2711783956719;1013.8377859542438;1014.9289549731595;1015.1878497202209;1027.866377370937;10393;10470.371777693363;10497.16022718196;10621.362718236931;10737.731556711145;437161;441921;454852;456319;458885;108487.45756271169;113684;116804;117812.41093794476;119632.40183799026;1128.7178205448638;1145.1983611472003;1146.2320245435412;1149.2989276541302;1152.2970987697497;16903.577410564834;17108.657826843144;17208.483745487654;17210.827891721423;17286.394976175772;55778;56423.71788141033;56463;57564.136537951126;57658.7117064412;71782.28217717756;71891.28108718846;72134.63932680304;72291.27708722846;73737;18869.528261793566;19069.809301906804;19200.519987000436;19399.4180174595;19430.514237144183;21489.925503725062;21527.354179374644;21588.46028849291;21812.454688632275;22021.669674954566;17061.57346066358;17117.400890968755;17307.3942412015;17465;18078.728819067463;15114.622134446727;15335.386584536494;15683.607909802346;16545.91727041405;16793.580160496087;17213.65572688564;17439.82560174382;17713.822861771216;17810.465686029438;18112;19010.049497524793;19027.71458428097;19110.617787643892;19158.32945846889;19302.903485482482;17338.566535836704;17382.217800199276;17407.651846962737;17464.82535174683;17551.82448175502 02:25:15 INFO - PID 1850 | |3;mootools.html;1303.9608811735648;1391.311300906051;1403.95086171984;1404.950826721065;1405.9086159399637;14710.63223419415;15231.84768152318;15267.694646107086;15367.308471118798;15376;15142.470013549528;15157.242137893089;15169.620759481018;15229.086254824719;15280.923595382008;2666.3334166458385;2702.1083042595897;2744.2727677165567;2758.3104223944015;2763.198672385016;2683.7047924728263;2757.4347258811995;2761.8619069046567;2782.9025984090563;2789.4560560690675;2612.830166039211;2786.2755683522328;2795.7903157263186;2800.3979144483933;2803.327201471642;2781.5271403861293;2789.316617428743;2809.592609071673;2832.34855983124;2856.742893139617;2763.69599344072;2768.0726956469607;2779.555271156605;2786.3730660601404;2800.187945495804;14755.926220368936;14940.850591494054;15059.096454212782;15098.622534436618;15105.39578416862;7888;8093;8158.061822890325;8169.468984515987;8174.6730130794695;5104.05574968632;5114.43741188469;5215.16557350822;5284.445133260991;5389.272448219479;1749.4314347836876;1834.7431359609666;1908.4370110817204;1947.474181970874;1960.3334866145578;25825.870870645715;26687;26872.59691104635;26937.24907881001;26970.865145674343;6574.211094668671;6652.534322597372;6692.698828552727;6903.930960690429;6907.551009184387;16923.746143807854;16967.66064678724;16968.23642936071;17023.48929532116;17054.317827287017;7680.615969201517;7773.922260777433;7832.334251588565;7862.606869656494;7880.133185349607;7166.749163779243;7270.091238595176;7292.854142917112;7383.372413344926;7441.181470038291;5096.898062038738;5144.536991670768;5212.55693266069;5268.736563171826;5411.567074634098;1452.8837692984537;1463.0709499467914;1466.3767898643034;1469.3461409672593;1474.8598883106088;874.2175752701423;877.6182360673;897.6588896219395;898.0974121008345;905.7916679163698;7267.30960558746;7346.449016323797;7411.59236242001;7421.183669796318;7421.925780742232;662.1888186970922;671.0906721392442;672.6670298202421;675.2437270257343;683.4293365040148;4725.36207611968;5129.538341549204;5133.743312834344;5146.639735218574;5155.7679904404395;21088.578228435344;21737.456563586038;21755.891220543795;21830.89084554567;21970.89014554917;20380;21316.680249796267;21318.680219796715;21355.46611334729;21664.675029874565;10679.466026698634;10851;10981.066609338135;11058;11092.944535277273;8045.798855028437;8103.108658047492;8163.673453061811;8166.959165204374;8208.179182081984;17090.48728538146;17968.371107011193;17979.370722024665;18120.818791812442;18490.260389584804;18828.717569236745;18865.15106820169;19473.318433854747;19551.804481954998;19651.901740491205;10229.693109206735;10717.839232411365;10823.080038196842;10943.616973405893;10946.835797462885;13506.72986540244;13599;13651.658708532366;13752;13778.311084445939;10126.645567405105;10284.537195826057;10463.58145674195;10618.469076546296;10654.946725266323;10464.424456654957;10482.318649287772;10493.370397776158;10513.158947284046;10632.096271816672;9703.12671859536;9810.460424676712;9883.357581757164;9903.752406189902;9918.950405247928;6980.6509674515055;7191.748288810076;7232.63836808168;7243.782686519413;7250.854982900418;7028.9297107030325;7073.71705131789;7238.746643867439;7261.38278246355;7305.671244793891 02:25:15 INFO - PID 1850 | |4;prototype.html;495.32278037208874;508.5880436846155;521.4785214785214;525.6005435868739;534.8368747532003;6279.246490421145;6284.654344011077;6289.339619339972;6337.461315788152;6345.968270158654;6159.168512250845;6185.4433101020895;6218.657973811439;6232.813015609528;6243;5108.058937603715;5114.769835357418;5131.435542090367;5157.767900444489;5175.482451754813;5102.744862756866;5119.513646203604;5122.871928201787;5141.871453213662;5152.381714194302;4711.528847115295;4813.831515896944;4984.925226121611;5093.974530127344;5098.949010509903;4829.034193161364;4833.613310935117;4870.172070747982;4872.585830204437;4882.877928051792;4302.720323178984;4352.586504282088;4363.454568178978;4365.170617582649;4390.604845563915;5880.323762767251;6069.908951365733;6078.452939235446;6102.589477156498;6112.63324200545;5465.6447330923365;5497.670139791625;5497.670139791625;5558.722063896829;5582.553395728332;6492.7402903883785;6497.278221271366;6524.543281970264;6526.706298216592;6533.150690410263;4525.841595544141;4670.136024835382;4707.929381059287;4766.809327626891;4774.928376074362;6557.803265902031;6703.363180497845;6759.188897332253;6781.932180678179;6826.795196144124;4816.133096042676;4817.518248175154;4820.373351464357;4824.614030877521;4845.079434907427;4881.975590122027;4927.28554359623;4938.38270216223;4959.70241785494;4966.925496117561;5487.286652735119;5519.254900588449;5565.16522521625;5586.91619625706;5601.887962240814;6537.542372033912;6569.211694596679;6578.8355291118105;6614.677064587102;6625.734970601218;1704.9173774653184;1708.2056843567552;1719.2864961041278;1721.7073097573443;1725.3788636090997;1130.3331034689572;1181.6100686773343;1191.9570375921069;1193.4689063366893;1198.7542553776454;5555.333359996826;5573.860653483695;5591.664500130005;5638.718064096779;5653.717314134359;6535.22253042455;6586.176727909012;6605.8348541285895;6676.332366763382;6692.397684208445;5602.915956260659;5652.236948012048;5662.094064949671;5683;5684.232628595169;3496.5629296337956;3504.649535046526;3538.9469157962653;3542.3623747725655;3555.5022296878456;6344.6827658616885;6362.618242905441;6396.1045453636525;6454.4513716333695;6472.255690595642;6652.27472615337;6664.133662623828;6844.5208835382045;6862.245153033163;6896.379325860697;6240.28236752761;6305.747770089237;6337.809865704036;6358.968205158944;6376.1392212051705;6480.902786458301;6560.9343906562235;6573.80278591643;6597.208334999831;6599.307072757291;6005.330059293398;6449.7420103195345;6480.708368123352;6541.8691626168165;6554;6312.506559908902;6338.58799178052;6380.266269379081;6433.517486188648;6457.838554036187;4800.711957282435;4812;4825.324454576432;4833;4862.4651288357545;6426.646534440463;6457.225132984072;6552.803415897531;6637.38701602401;6729.1924969002075;6396.616203027833;6441.581297215666;6445.774397896051;6457.6771161442675;6530.706118224786;6353.523485738496;6395.040743888454;6395.168628078506;6423.710933008119;6463.482921366185;6223.159873417212;6349.238091429058;6352.428281454691;6381.521385895983;6397.264314603694;6420.6147631142285;6454.451371633276;6475.967620161869;6481.837954051187;6513.5018945643715;6183.628982261079;6185.195924529782;6261.592996455216;6284.151639528605;6302.65335406557 02:25:15 INFO - PID 1850 | |5;yui.html;886.7694399456142;918.4994178172896;923.6443969071905;926.305271046715;931.0410277414261;19323.420297391083;20200.19199232031;20281.898590507044;20296.59406811863;20339.49151271219;18278.90860545699;18305.267789288446;18372.44882653519;18397.356092536764;18450.261989520437;929.7396728915897;944.6976967370445;945.6170251048336;949.3544389814923;950.8668786369914;942.528735632184;947.8909675679472;947.943123412594;948.3693343926316;948.6632245552833;977.0815433492494;997.9251556133282;1002.6791426743445;1003.8594596756424;1012.084063922148;984.8325784616633;986.2061040862139;990.88604810447;991.7272749993738;997.062761004657;732.179958446538;734.4528326396869;735.6358602491747;736.3556887723242;738.6122285799944;19152.329668461538;19672.213111475525;19699.704504432302;19753.901230493757;20083;21726.89136554307;21912.45218869525;22000.669989950162;22143.114275428965;22236.221732239293;17217.91391043037;17418.825811741975;17618.119094045247;17628.91185544077;17633.294668213384;3557.7153827693724;3594.3530164570366;3600.279944011182;3605.134767655744;3608.4226523756333;102303;103122.48438757833;141554;144674.27662861723;145669.27165364212;16977;17013.659726805643;17089;17393.130343482775;17498;31771.84114079415;31811.68188318087;31824.84087579547;31967.200819979687;32046.359072818414;8507.53208573522;8762.824743505222;8768.342374321952;8799.340049496313;8826.514541700268;4130;4172.186423647359;4196.916061678749;4222.218889505451;4240.915181696349;5260.763265653055;5289.629725919149;5368.570514358842;5377.3816011159215;5412.296401467784;1043.2488608202082;1070.5075665193942;1077.8113830079863;1080.1197024425069;1080.9567617295377;689.9793006209821;705.2911823617231;711.1253158614829;720.218562859293;720.945929055323;11321.660350189508;11567.76864462706;11893.940530297294;12375.876241237653;12410.627681169579;653.6992983227768;661.798151563768;665.2216906219735;669.6885948034187;681.1077488490093;5424.837254882281;5448.818427456112;5458.372287186945;5500.862478438071;5535.667859928417;114938.42530787292;116323;118571.40714296373;119564;120010.39994800145;108351.12419940963;108827.45586272018;111029;111159;112764;91269;97997;98418.50790746;98544;100588.4970575157;9995.900040999788;10111.7472063199;10160.796784064425;10260.12788912921;10263.332883362558;44615.33077003912;44664.55335446734;45260;45829.54170458253;46304.768476157406;57043.71478142583;57770.711146444;58228.41771582399;58431;59731.402685972585;15116.622084447978;15281.46514871974;15391.61520961985;15508.92245538765;15607.843921561092;14655.853441465875;14770.187639679922;14779.852201477848;14825;14855.851441485447;14289.428422863384;14311.499097531536;14349.139051656934;14453.4941277059;14566.271686415424;15010;15079.698406031599;15178.392864285304;15398.692026159639;15485.84514154844;13500.5274815381;13819.723605527632;13861.792073119113;13890.722185556435;13893;10010;10110.545025474019;10247.48762561854;10257.17942564608;10312.793744124925;10853.457327133454;10914.181436392144;10960.28758130719;10965.945170274097;11145.609903653658 02:25:15 INFO - PID 1850 | __end_tp_report 02:25:15 INFO - PID 1850 | __start_cc_report 02:25:15 INFO - PID 1850 | _x_x_mozilla_cycle_collect,361 02:25:15 INFO - PID 1850 | __end_cc_report 02:25:15 INFO - PID 1850 | __startTimestamp1505035515047__endTimestamp 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | ------- Summary: start ------- 02:25:15 INFO - PID 1850 | Number of tests: 6 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | [#0] dojo.html Cycles:165 Average:6111.80 Median:6396.52 stddev:860.77 (13.5%) stddev-sans-first:829.43 02:25:15 INFO - PID 1850 | Values: 3059.1 3091.8 3099.6 3123.4 3136.2 6211.3 6235.6 6283.6 6284.9 6303.4 6154.0 6158.9 6176.6 6191.7 6225.8 5696.7 5707.8 5751.1 5754.1 5796.0 5768.5 5823.5 5829.8 5841.7 5881.3 5786.6 5802.9 5862.5 5871.1 5881.9 474.5 5605.6 5662.2 5801.2 5822.6 5669.3 5708.3 5724.5 5788.2 5794.7 6216.1 6242.1 6244.4 6244.9 6301.0 6651.4 6660.6 6663.0 6750.6 6756.8 6654.3 6713.4 6740.0 6816.1 6816.9 6072.2 6180.4 6202.2 6233.7 6273.7 6870.8 6924.7 6929.2 6933.0 6963.9 6557.0 6589.7 6643.5 6645.1 6648.4 6683.0 6706.9 6727.2 6807.6 6822.0 6476.9 6587.1 6609.9 6621.7 6704.7 6578.8 6588.9 6605.3 6615.4 6617.9 5192.3 5215.4 5297.3 5297.7 5298.5 4500.1 4536.2 4548.3 4554.3 4669.6 5736.4 5773.3 5807.6 5810.0 5815.9 6633.8 6676.7 6724.5 6770.1 6798.4 5587.1 5694.8 5706.7 5781.1 5798.9 5685.6 5715.6 5791.8 5795.7 5797.9 6471.7 6488.5 6488.6 6520.5 6538.2 6583.9 6660.4 6695.1 6768.4 6768.9 6400.4 6444.0 6489.8 6513.6 6515.4 6426.4 6520.2 6553.5 6610.9 6628.2 6659.0 6690.7 6752.4 6759.5 6761.1 6414.9 6429.9 6470.2 6518.4 6525.9 6420.0 6457.1 6462.7 6508.7 6527.3 6271.2 6375.4 6396.5 6459.7 6485.4 6511.5 6532.7 6564.4 6591.1 6602.0 6240.6 6250.7 6293.2 6331.7 6350.3 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | [#1] ext.html Cycles:180 Average:36063.53 Median:34309.90 stddev:50227.79 (146.4%) stddev-sans-first:50299.07 02:25:15 INFO - PID 1850 | Values: 843.4 867.4 893.0 895.1 897.0 38675.0 39383.4 39423.8 39816.0 39820.6 38259.6 39368.4 39459.8 39597.4 39671.2 7642.5 7684.5 7717.5 7719.0 7728.0 7641.0 7725.3 7767.1 7773.4 7781.8 7735.0 7742.4 7754.7 7772.8 7803.0 7693.2 7711.5 7726.3 7754.3 7774.5 7633.0 7681.7 7694.5 7699.3 7699.7 36658.0 36796.0 36987.8 37021.3 37021.8 3568.9 3599.3 3602.3 3603.4 3604.6 30829.8 30848.4 30873.0 30879.2 30925.4 5149.9 5190.7 5190.8 5212.2 5245.3 177050.0 177747.0 178581.0 178642.0 179293.0 45648.5 45743.8 45866.1 45901.3 46005.8 50677.5 51423.2 51534.7 51615.5 51744.7 15777.4 15968.8 15992.8 16104.9 16121.9 13035.1 13115.9 13117.8 13251.1 13292.3 13963.5 14030.1 14063.0 14102.7 14105.7 5777.9 5828.7 5966.8 5995.9 6010.7 997.6 1001.7 1010.0 1017.5 1030.6 22501.3 22513.5 22573.2 22806.2 23005.3 1089.2 1100.9 1110.7 1112.5 1125.4 11915.4 12027.5 12088.9 12131.8 12132.2 208603.0 211913.0 212467.0 213532.0 213902.0 43298.0 44181.8 49818.0 50344.5 55099.7 1402.5 1432.8 1454.6 1466.0 1469.4 27173.0 27227.9 27496.5 27517.2 27850.3 33551.5 33649.2 33680.5 33764.3 33847.2 191006.0 191113.0 191623.0 191914.0 192675.0 33400.0 34011.3 34608.5 34616.5 34633.7 39996.2 41368.0 41584.0 41629.6 41783.4 30468.2 31045.4 31100.7 31279.0 31422.7 31077.0 31164.2 31224.4 31261.0 31283.4 35057.3 35092.3 35325.0 35450.5 35547.6 30222.7 31009.6 31135.2 31158.5 31784.0 22168.4 23003.1 23060.3 23397.2 23468.9 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | [#2] jquery.html Cycles:180 Average:34476.47 Median:21548.41 stddev:76273.81 (354.0%) stddev-sans-first:76445.27 02:25:15 INFO - PID 1850 | Values: 560.5 572.6 573.2 580.9 581.1 22158.1 22732.5 23117.9 23222.7 23306.5 23429.8 24416.8 24533.5 24888.6 25020.9 6368.5 6527.5 6546.7 6550.9 6576.3 6356.2 6451.6 6485.5 6504.6 6506.5 6149.8 6433.6 6440.4 6444.6 6447.6 6440.2 6479.5 6483.6 6491.9 6493.8 5960.5 5962.2 5992.3 6016.8 6542.9 29379.3 30184.5 30213.5 30237.7 30248.7 2048.9 2073.0 2082.4 2091.4 2092.6 19922.8 20213.5 20459.8 20576.5 21164.5 2453.9 2521.2 2524.6 2530.9 2537.7 123881.0 129616.4 138469.3 144289.0 144378.3 19906.9 20053.2 20300.5 20745.3 21569.5 41006.8 41009.8 41268.0 41387.4 41563.4 11195.8 11292.2 11436.3 11594.2 11613.2 9517.5 9672.4 9697.1 9708.9 9881.6 10577.6 10607.9 11216.1 11306.1 11413.8 3660.5 3920.4 4057.2 4062.6 4137.9 958.7 959.8 969.1 975.3 981.1 18330.8 18412.5 18810.1 18862.1 19109.3 1005.3 1013.8 1014.9 1015.2 1027.9 10393.0 10470.4 10497.2 10621.4 10737.7 437161.0 441921.0 454852.0 456319.0 458885.0 108487.5 113684.0 116804.0 117812.4 119632.4 1128.7 1145.2 1146.2 1149.3 1152.3 16903.6 17108.7 17208.5 17210.8 17286.4 55778.0 56423.7 56463.0 57564.1 57658.7 71782.3 71891.3 72134.6 72291.3 73737.0 18869.5 19069.8 19200.5 19399.4 19430.5 21489.9 21527.4 21588.5 21812.5 22021.7 17061.6 17117.4 17307.4 17465.0 18078.7 15114.6 15335.4 15683.6 16545.9 16793.6 17213.7 17439.8 17713.8 17810.5 18112.0 19010.0 19027.7 19110.6 19158.3 19302.9 17338.6 17382.2 17407.7 17464.8 17551.8 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | [#3] mootools.html Cycles:180 Average:9185.85 Median:2757.87 stddev:6634.45 (240.6%) stddev-sans-first:6626.63 02:25:15 INFO - PID 1850 | Values: 1304.0 1391.3 1404.0 1405.0 1405.9 14710.6 15231.8 15267.7 15367.3 15376.0 15142.5 15157.2 15169.6 15229.1 15280.9 2666.3 2702.1 2744.3 2758.3 2763.2 2683.7 2757.4 2761.9 2782.9 2789.5 2612.8 2786.3 2795.8 2800.4 2803.3 2781.5 2789.3 2809.6 2832.3 2856.7 2763.7 2768.1 2779.6 2786.4 2800.2 14755.9 14940.9 15059.1 15098.6 15105.4 7888.0 8093.0 8158.1 8169.5 8174.7 5104.1 5114.4 5215.2 5284.4 5389.3 1749.4 1834.7 1908.4 1947.5 1960.3 25825.9 26687.0 26872.6 26937.2 26970.9 6574.2 6652.5 6692.7 6903.9 6907.6 16923.7 16967.7 16968.2 17023.5 17054.3 7680.6 7773.9 7832.3 7862.6 7880.1 7166.7 7270.1 7292.9 7383.4 7441.2 5096.9 5144.5 5212.6 5268.7 5411.6 1452.9 1463.1 1466.4 1469.3 1474.9 874.2 877.6 897.7 898.1 905.8 7267.3 7346.4 7411.6 7421.2 7421.9 662.2 671.1 672.7 675.2 683.4 4725.4 5129.5 5133.7 5146.6 5155.8 21088.6 21737.5 21755.9 21830.9 21970.9 20380.0 21316.7 21318.7 21355.5 21664.7 10679.5 10851.0 10981.1 11058.0 11092.9 8045.8 8103.1 8163.7 8167.0 8208.2 17090.5 17968.4 17979.4 18120.8 18490.3 18828.7 18865.2 19473.3 19551.8 19651.9 10229.7 10717.8 10823.1 10943.6 10946.8 13506.7 13599.0 13651.7 13752.0 13778.3 10126.6 10284.5 10463.6 10618.5 10654.9 10464.4 10482.3 10493.4 10513.2 10632.1 9703.1 9810.5 9883.4 9903.8 9919.0 6980.7 7191.7 7232.6 7243.8 7250.9 7028.9 7073.7 7238.7 7261.4 7305.7 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | [#4] prototype.html Cycles:180 Average:5425.47 Median:6135.90 stddev:1524.87 (24.9%) stddev-sans-first:1483.57 02:25:15 INFO - PID 1850 | Values: 495.3 508.6 521.5 525.6 534.8 6279.2 6284.7 6289.3 6337.5 6346.0 6159.2 6185.4 6218.7 6232.8 6243.0 5108.1 5114.8 5131.4 5157.8 5175.5 5102.7 5119.5 5122.9 5141.9 5152.4 4711.5 4813.8 4984.9 5094.0 5098.9 4829.0 4833.6 4870.2 4872.6 4882.9 4302.7 4352.6 4363.5 4365.2 4390.6 5880.3 6069.9 6078.5 6102.6 6112.6 5465.6 5497.7 5497.7 5558.7 5582.6 6492.7 6497.3 6524.5 6526.7 6533.2 4525.8 4670.1 4707.9 4766.8 4774.9 6557.8 6703.4 6759.2 6781.9 6826.8 4816.1 4817.5 4820.4 4824.6 4845.1 4882.0 4927.3 4938.4 4959.7 4966.9 5487.3 5519.3 5565.2 5586.9 5601.9 6537.5 6569.2 6578.8 6614.7 6625.7 1704.9 1708.2 1719.3 1721.7 1725.4 1130.3 1181.6 1192.0 1193.5 1198.8 5555.3 5573.9 5591.7 5638.7 5653.7 6535.2 6586.2 6605.8 6676.3 6692.4 5602.9 5652.2 5662.1 5683.0 5684.2 3496.6 3504.6 3538.9 3542.4 3555.5 6344.7 6362.6 6396.1 6454.5 6472.3 6652.3 6664.1 6844.5 6862.2 6896.4 6240.3 6305.7 6337.8 6359.0 6376.1 6480.9 6560.9 6573.8 6597.2 6599.3 6005.3 6449.7 6480.7 6541.9 6554.0 6312.5 6338.6 6380.3 6433.5 6457.8 4800.7 4812.0 4825.3 4833.0 4862.5 6426.6 6457.2 6552.8 6637.4 6729.2 6396.6 6441.6 6445.8 6457.7 6530.7 6353.5 6395.0 6395.2 6423.7 6463.5 6223.2 6349.2 6352.4 6381.5 6397.3 6420.6 6454.5 6476.0 6481.8 6513.5 6183.6 6185.2 6261.6 6284.2 6302.7 02:25:15 INFO - PID 1850 | 02:25:15 INFO - PID 1850 | [#5] yui.html Cycles:180 Average:23764.88 Median:20289.25 stddev:34381.07 (169.5%) stddev-sans-first:34434.60 02:25:15 INFO - PID 1850 | Values: 886.8 918.5 923.6 926.3 931.0 19323.4 20200.2 20281.9 20296.6 20339.5 18278.9 18305.3 18372.4 18397.4 18450.3 929.7 944.7 945.6 949.4 950.9 942.5 947.9 947.9 948.4 948.7 977.1 997.9 1002.7 1003.9 1012.1 984.8 986.2 990.9 991.7 997.1 732.2 734.5 735.6 736.4 738.6 19152.3 19672.2 19699.7 19753.9 20083.0 21726.9 21912.5 22000.7 22143.1 22236.2 17217.9 17418.8 17618.1 17628.9 17633.3 3557.7 3594.4 3600.3 3605.1 3608.4 102303.0 103122.5 141554.0 144674.3 145669.3 16977.0 17013.7 17089.0 17393.1 17498.0 31771.8 31811.7 31824.8 31967.2 32046.4 8507.5 8762.8 8768.3 8799.3 8826.5 4130.0 4172.2 4196.9 4222.2 4240.9 5260.8 5289.6 5368.6 5377.4 5412.3 1043.2 1070.5 1077.8 1080.1 1081.0 690.0 705.3 711.1 720.2 720.9 11321.7 11567.8 11893.9 12375.9 12410.6 653.7 661.8 665.2 669.7 681.1 5424.8 5448.8 5458.4 5500.9 5535.7 114938.4 116323.0 118571.4 119564.0 120010.4 108351.1 108827.5 111029.0 111159.0 112764.0 91269.0 97997.0 98418.5 98544.0 100588.5 9995.9 10111.7 10160.8 10260.1 10263.3 44615.3 44664.6 45260.0 45829.5 46304.8 57043.7 57770.7 58228.4 58431.0 59731.4 15116.6 15281.5 15391.6 15508.9 15607.8 14655.9 14770.2 14779.9 14825.0 14855.9 14289.4 14311.5 14349.1 14453.5 14566.3 15010.0 15079.7 15178.4 15398.7 15485.8 13500.5 13819.7 13861.8 13890.7 13893.0 10010.0 10110.5 10247.5 10257.2 10312.8 10853.5 10914.2 10960.3 10965.9 11145.6 02:25:15 INFO - PID 1850 | -------- Summary: end -------- 02:25:15 INFO - PID 1850 | 02:25:15 INFO - TEST-INFO | 1850: exit 0 02:25:15 INFO - TEST-OK | dromaeo_css | took 1113887ms 02:25:15 INFO - TEST-START | kraken 02:25:15 INFO - Initialising browser for kraken test... 02:25:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35123/getInfo.html -profile /tmp/tmp5grW9N/profile 02:25:15 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/firefox/firefox http://localhost:35123/getInfo.html) 02:25:22 INFO - TEST-INFO | 2241: exit 0 02:25:22 INFO - Browser initialized. 02:25:22 INFO - Running cycle 1/1 for kraken test... 02:25:22 INFO - Using env: {'DISPLAY': ':0', 02:25:22 INFO - 'HOME': '/home/cltbld', 02:25:22 INFO - 'JSGC_DISABLE_POISONING': '1', 02:25:22 INFO - 'LANG': 'en_US.UTF-8', 02:25:22 INFO - 'LANGUAGE': 'en_US:en', 02:25:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:25:22 INFO - 'LOGNAME': 'cltbld', 02:25:22 INFO - 'MAIL': '/var/mail/cltbld', 02:25:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:25:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:25:22 INFO - 'MOZ_ACCELERATED': '1', 02:25:22 INFO - 'MOZ_CRASHREPORTER': '1', 02:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:25:22 INFO - 'MOZ_NO_REMOTE': '1', 02:25:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:25:22 INFO - 'MOZ_WEBRENDER': '1', 02:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:22 INFO - 'NO_EM_RESTART': '1', 02:25:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:22 INFO - 'PWD': '/builds/slave/test', 02:25:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:25:22 INFO - 'RUST_BACKTRACE': 'full', 02:25:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:25:22 INFO - 'SHELL': '/bin/bash', 02:25:22 INFO - 'SHLVL': '1', 02:25:22 INFO - 'TERM': 'linux', 02:25:22 INFO - 'TMOUT': '86400', 02:25:22 INFO - 'USER': 'cltbld', 02:25:22 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084', 02:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:22 INFO - '_': '/tools/buildbot/bin/python'} 02:25:22 INFO - TEST-INFO | started process 2453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5grW9N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:23 INFO - PID 2453 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:25:23 INFO - PID 2453 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:25:23 INFO - PID 2453 | 02:25:23 INFO - PID 2453 | (/builds/slave/test/build/application/firefox/firefox:2513): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:25:23 INFO - PID 2453 | 02:25:33 INFO - PID 2453 | RSS: Main: 207618048 02:25:33 INFO - PID 2453 | 02:25:36 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:37 INFO - PID 2453 | RSS: Main: 213716992 02:25:37 INFO - PID 2453 | 02:25:40 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-dft) 02:25:40 INFO - PID 2453 | RSS: Main: 213557248 02:25:40 INFO - PID 2453 | 02:25:44 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-fft) 02:25:44 INFO - PID 2453 | RSS: Main: 210255872 02:25:44 INFO - PID 2453 | 02:25:46 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35123/tests/kraken/driver.html?testName=audio-oscillator) 02:25:47 INFO - PID 2453 | RSS: Main: 210120704 02:25:47 INFO - PID 2453 | 02:25:49 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:50 INFO - PID 2453 | RSS: Main: 212418560 02:25:50 INFO - PID 2453 | 02:25:53 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35123/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:54 INFO - PID 2453 | RSS: Main: 215076864 02:25:54 INFO - PID 2453 | 02:25:57 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35123/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:58 INFO - PID 2453 | RSS: Main: 213172224 02:25:58 INFO - PID 2453 | 02:26:01 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35123/tests/kraken/driver.html?testName=json-parse-financial) 02:26:02 INFO - PID 2453 | RSS: Main: 214052864 02:26:02 INFO - PID 2453 | 02:26:03 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:04 INFO - PID 2453 | RSS: Main: 213381120 02:26:04 INFO - PID 2453 | 02:26:06 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:06 INFO - PID 2453 | RSS: Main: 213696512 02:26:06 INFO - PID 2453 | 02:26:08 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:09 INFO - PID 2453 | RSS: Main: 214257664 02:26:09 INFO - PID 2453 | 02:26:12 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:12 INFO - PID 2453 | RSS: Main: 214962176 02:26:12 INFO - PID 2453 | 02:26:15 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:16 INFO - PID 2453 | RSS: Main: 215212032 02:26:16 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | Cycle 1(1): loaded http://localhost:35123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35123/tests/kraken/driver.html?testName=ai-astar) 02:26:18 INFO - PID 2453 | RSS: Main: 217645056 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | __start_tp_report 02:26:18 INFO - PID 2453 | _x_x_mozilla_page_load 02:26:18 INFO - PID 2453 | _x_x_mozilla_page_load_details 02:26:18 INFO - PID 2453 | |i|pagename|runs| 02:26:18 INFO - PID 2453 | |0;ai-astar;112;117;113;116;115;113;115;109;117;112 02:26:18 INFO - PID 2453 | |1;audio-beat-detection;118;121;130;123;115;126;126;122;124;122 02:26:18 INFO - PID 2453 | |2;audio-dft;166;163;166;163;176;172;167;169;165;162 02:26:18 INFO - PID 2453 | |3;audio-fft;77;79;74;78;79;80;81;79;82;74 02:26:18 INFO - PID 2453 | |4;audio-oscillator;81;86;85;86;86;90;81;82;81;79 02:26:18 INFO - PID 2453 | |5;imaging-gaussian-blur;115;116;115;118;127;115;114;118;117;115 02:26:18 INFO - PID 2453 | |6;imaging-darkroom;149;149;148;149;149;155;148;148;152;153 02:26:18 INFO - PID 2453 | |7;imaging-desaturate;95;95;94;94;95;99;95;95;95;99 02:26:18 INFO - PID 2453 | |8;json-parse-financial;59;53;51;55;54;54;56;53;56;53 02:26:18 INFO - PID 2453 | |9;json-stringify-tinderbox;37;47;48;42;42;38;40;37;43;45 02:26:18 INFO - PID 2453 | |10;stanford-crypto-aes;75;77;78;81;77;82;76;76;80;75 02:26:18 INFO - PID 2453 | |11;stanford-crypto-ccm;128;139;116;123;130;122;125;125;123;117 02:26:18 INFO - PID 2453 | |12;stanford-crypto-pbkdf2;169;167;175;177;177;172;169;180;167;169 02:26:18 INFO - PID 2453 | |13;stanford-crypto-sha256-iterative;63;65;63;66;68;64;65;66;64;69 02:26:18 INFO - PID 2453 | __end_tp_report 02:26:18 INFO - PID 2453 | __start_cc_report 02:26:18 INFO - PID 2453 | _x_x_mozilla_cycle_collect,948 02:26:18 INFO - PID 2453 | __end_cc_report 02:26:18 INFO - PID 2453 | __startTimestamp1505035578537__endTimestamp 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | ------- Summary: start ------- 02:26:18 INFO - PID 2453 | Number of tests: 14 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:2.56 (2.2%) stddev-sans-first:2.62 02:26:18 INFO - PID 2453 | Values: 112.0 117.0 113.0 116.0 115.0 113.0 115.0 109.0 117.0 112.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:123.50 stddev:4.24 (3.4%) stddev-sans-first:4.15 02:26:18 INFO - PID 2453 | Values: 118.0 121.0 130.0 123.0 115.0 126.0 126.0 122.0 124.0 122.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.50 stddev:4.38 (2.6%) stddev-sans-first:4.64 02:26:18 INFO - PID 2453 | Values: 166.0 163.0 166.0 163.0 176.0 172.0 167.0 169.0 165.0 162.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#3] audio-fft Cycles:10 Average:78.30 Median:79.00 stddev:2.67 (3.4%) stddev-sans-first:2.79 02:26:18 INFO - PID 2453 | Values: 77.0 79.0 74.0 78.0 79.0 80.0 81.0 79.0 82.0 74.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:85.50 stddev:3.40 (4.0%) stddev-sans-first:3.46 02:26:18 INFO - PID 2453 | Values: 81.0 86.0 85.0 86.0 86.0 90.0 81.0 82.0 81.0 79.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:116.50 stddev:3.77 (3.2%) stddev-sans-first:3.93 02:26:18 INFO - PID 2453 | Values: 115.0 116.0 115.0 118.0 127.0 115.0 114.0 118.0 117.0 115.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:149.00 stddev:2.45 (1.6%) stddev-sans-first:2.57 02:26:18 INFO - PID 2453 | Values: 149.0 149.0 148.0 149.0 149.0 155.0 148.0 148.0 152.0 153.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.84 (1.9%) stddev-sans-first:1.94 02:26:18 INFO - PID 2453 | Values: 95.0 95.0 94.0 94.0 95.0 99.0 95.0 95.0 95.0 99.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:2.22 (4.1%) stddev-sans-first:1.62 02:26:18 INFO - PID 2453 | Values: 59.0 53.0 51.0 55.0 54.0 54.0 56.0 53.0 56.0 53.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#9] json-stringify-tinderbox Cycles:10 Average:41.90 Median:42.50 stddev:3.96 (9.3%) stddev-sans-first:3.78 02:26:18 INFO - PID 2453 | Values: 37.0 47.0 48.0 42.0 42.0 38.0 40.0 37.0 43.0 45.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.50 (3.2%) stddev-sans-first:2.45 02:26:18 INFO - PID 2453 | Values: 75.0 77.0 78.0 81.0 77.0 82.0 76.0 76.0 80.0 75.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.00 stddev:6.60 (5.3%) stddev-sans-first:6.89 02:26:18 INFO - PID 2453 | Values: 128.0 139.0 116.0 123.0 130.0 122.0 125.0 125.0 123.0 117.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.50 stddev:4.71 (2.7%) stddev-sans-first:4.85 02:26:18 INFO - PID 2453 | Values: 169.0 167.0 175.0 177.0 177.0 172.0 169.0 180.0 167.0 169.0 02:26:18 INFO - PID 2453 | 02:26:18 INFO - PID 2453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.00 (3.1%) stddev-sans-first:1.94 02:26:18 INFO - PID 2453 | Values: 63.0 65.0 63.0 66.0 68.0 64.0 65.0 66.0 64.0 69.0 02:26:18 INFO - PID 2453 | -------- Summary: end -------- 02:26:18 INFO - PID 2453 | 02:26:19 INFO - PID 2453 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:26:19 INFO - TEST-INFO | 2453: exit 0 02:26:19 INFO - TEST-OK | kraken | took 63536ms 02:26:19 INFO - SUITE-END | took 1177s 02:26:19 INFO - Completed test suite (00:19:37) 02:26:19 INFO - javascript benchmark 02:26:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8446.13713302493, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.0975662179662, 3091.7681173911933, 3099.5505651680505, 3123.39093876694, 3136.2002689314236, 6211.31675515694, 6235.563510554269, 6283.591566548172, 6284.905726414102, 6303.401176888194, 6154.015357542794, 6158.938410615892, 6176.567640265183, 6191.721372538235, 6225.844353891155, 5696.715164241771, 5707.77168913243, 5751.10857817037, 5754.079347304432, 5795.971020144893, 5768.509676677488, 5823.475887170154, 5829.766809327622, 5841.678707671076, 5881.294244690622, 5786.56600754943, 5802.883942321151, 5862.50168735658, 5871.119332100197, 5881.941180588182, 474.46171553112157, 5605.607607467479, 5662.178984047331, 5801.216835727165, 5822.621529600562, 5669.291338582677, 5708.286464191976, 5724.484796368305, 5788.218590490272, 5794.68129252891, 6216.067589861512, 6242.1261023456755, 6244.3755624437645, 6244.906326405107, 6301.023341382093, 6651.401373876326, 6660.633665148415, 6662.966685166543, 6750.594964302109, 6756.8310792230095, 6654.26803051664, 6713.429358504533, 6740.0, 6816.113905192343, 6816.897746533806, 6072.210612620331, 6180.412860778219, 6202.162708034402, 6233.688315584202, 6273.749050037993, 6870.7595234166565, 6924.688389022405, 6929.237783843773, 6933.0293758873795, 6963.9303606964295, 6557.0, 6589.670516474157, 6643.534952553275, 6645.06969024337, 6648.434883034899, 6682.966585167141, 6706.93293067063, 6727.192736871607, 6807.625580593115, 6821.965890170617, 6476.935230647728, 6587.110740050128, 6609.933900661028, 6621.702023408958, 6704.698288577026, 6578.835529111715, 6588.901166482507, 6605.339466053356, 6615.404613584704, 6617.933820661828, 5192.299039629602, 5215.374155101412, 5297.258383826267, 5297.682139071668, 5298.470152984671, 4500.077484115748, 4536.206163921301, 4548.317752337176, 4554.27131658933, 4669.556392142741, 5736.42635736423, 5773.3072031356505, 5807.622504537191, 5810.041343178328, 5815.912761308584, 6633.834154146089, 6676.6661666917435, 6724.529282950147, 6770.052192693027, 6798.422134118655, 5587.1339942309005, 5694.800681976111, 5706.71466426677, 5781.103928891029, 5798.88402231953, 5685.6304340218585, 5715.599908006483, 5791.7683292667825, 5795.7391917362975, 5797.855053623609, 6471.741130354733, 6488.545801793829, 6488.578242414228, 6520.5435619507125, 6538.215414150332, 6583.868322633616, 6660.400563949268, 6695.096162018065, 6768.390844823989, 6768.898466523006, 6400.39196276353, 6444.033394990789, 6489.772857949949, 6513.609183449008, 6515.446187074152, 6426.357364263723, 6520.217573891164, 6553.541252112306, 6610.900836487361, 6628.204615445984, 6658.966705166443, 6690.665466726547, 6752.3922846944015, 6759.493038022069, 6761.0534525167495, 6414.903776443264, 6429.903551446639, 6470.158879345655, 6518.445932095825, 6525.9021114684265, 6419.967900160469, 6457.063725759833, 6462.676866156579, 6508.739650413931, 6527.314631963765, 6271.216097987752, 6375.362463753588, 6396.520260980352, 6459.741610335534, 6485.448736857231, 6511.544191906521, 6532.706028228646, 6564.409203171737, 6591.143151390289, 6601.966990165019, 6240.594361366497, 6250.656213908279, 6293.213348331458, 6331.746730130743, 6350.301466838551], "value": 6049.26302368991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.4475418600819, 867.3841572483536, 892.9910700892989, 895.1138373010717, 897.0177655467261, 38675.0, 39383.409248861215, 39423.802880985626, 39816.0, 39820.60179398209, 38259.617403825956, 39368.409473857915, 39459.802700986525, 39597.40603890944, 39671.206575868535, 7642.541447513153, 7684.500507467024, 7717.459777815555, 7719.0, 7728.033995750531, 7640.961795191016, 7725.343345815584, 7767.067951845786, 7773.378129749606, 7781.844363112763, 7735.033120859893, 7742.380609551223, 7754.651040703182, 7772.805679857992, 7803.02462192226, 7693.192214817447, 7711.537307761552, 7726.266004729542, 7754.302112809818, 7774.455788094864, 7633.0458692663415, 7681.692732290701, 7694.538327700356, 7699.345555627779, 7699.653515591812, 36658.0, 36796.0, 36987.81506092479, 37021.259574808624, 37021.81489092537, 3568.8750893718857, 3599.2621512590117, 3602.3155600436094, 3603.4234522476277, 3604.567451905762, 30829.845850770827, 30848.38303233923, 30873.0, 30879.228019299473, 30925.381492370027, 5149.922751158736, 5190.7404629768735, 5190.818321358772, 5212.218167274901, 5245.26566280721, 177050.0, 177747.0, 178581.0, 178642.0, 179293.0, 45648.54351456509, 45743.77128114338, 45866.08267834625, 45901.31148032782, 46005.76997114993, 50677.493225068014, 51423.22865157026, 51534.74232628813, 51615.48384516107, 51744.741276293375, 15777.447789327318, 15968.840311596967, 15992.76010859838, 16104.919475402548, 16121.919390403207, 13035.087543871838, 13115.934420328029, 13117.803232951514, 13251.13867598603, 13292.3353832308, 13963.511277105252, 14030.088044277089, 14063.0, 14102.71794564103, 14105.717885642229, 5777.8555536111935, 5828.708564571754, 5966.761329546856, 5995.850103747442, 6010.66941318223, 997.5660587644253, 1001.7295330260789, 1009.9697009089739, 1017.5370206555999, 1030.5877648940484, 22501.32496025122, 22513.531207988362, 22573.20993765243, 22806.201782937518, 23005.309840704806, 1089.1885545268826, 1100.873399559061, 1110.6501452042742, 1112.4660163121746, 1125.4035361258545, 11915.404229788475, 12027.458764355624, 12088.939555302168, 12131.818022729665, 12132.15074944763, 208603.0, 211913.0, 212467.0, 213532.0, 213902.0, 43298.0, 44181.77909110434, 49818.0, 50344.49655503471, 55099.72450137723, 1402.4810819996667, 1432.792245124472, 1454.6436123149685, 1466.047069404874, 1469.4122351059661, 27173.0, 27227.86386068057, 27496.450070998868, 27517.174484765488, 27850.303742406602, 33551.496727549595, 33649.15877103092, 33680.49479257764, 33764.3247135051, 33847.153821154665, 191006.0, 191113.0, 191623.0, 191914.0, 192675.0, 33400.0, 34011.31977360389, 34608.48087278743, 34616.48075278822, 34633.65366346304, 39996.2001709918, 41368.0, 41584.0, 41629.58370416257, 41783.373249400676, 30468.23829404194, 31045.379092417574, 31100.68899310978, 31279.0, 31422.70061643586, 31076.993721113955, 31164.220894477818, 31224.37551248917, 31261.0, 31283.37433251368, 35057.298854022265, 35092.298154037286, 35325.0, 35450.468242976895, 35547.64452355547, 30222.697773021988, 31009.604567794955, 31135.221619459695, 31158.532622011142, 31784.04647860568, 22168.445788854762, 23003.07987680474, 23060.308190754306, 23397.181098661466, 23468.94389752431], "value": 16912.1109400559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.48155456203, 572.5791543215736, 573.2204202284894, 580.8780156167205, 581.0876923230528, 22158.113675452983, 22732.54534909303, 23117.884410577964, 23222.65166022511, 23306.533869322604, 23429.76570234297, 24416.75583244167, 24533.509329813394, 24888.626670599955, 25020.87489562554, 6368.458681012119, 6527.510436717242, 6546.672666366687, 6550.8689826203445, 6576.342365763433, 6356.237251529823, 6451.645159516224, 6485.546011779177, 6504.609723416586, 6506.512011599125, 6149.784757533487, 6433.581817181892, 6440.420362167404, 6444.581102228363, 6447.5809072410375, 6440.162778838744, 6479.514036447262, 6483.578567393104, 6491.8701625967215, 6493.772717954873, 5960.523158147381, 5962.165296858443, 5992.310884248323, 6016.819495415145, 6542.855000374915, 29379.265518361997, 30184.54723179154, 30213.546796798066, 30237.69762302371, 30248.697513024807, 2048.8873111978837, 2073.0, 2082.37528741377, 2091.4039498742786, 2092.6442504774227, 19922.80077199224, 20213.494662633406, 20459.795402045936, 20576.485587860272, 21164.470888227763, 2453.8895749691305, 2521.2184222890965, 2524.5960646296503, 2530.860802655853, 2537.6574162488196, 123881.0, 129616.35191824075, 138469.3076534611, 144289.0, 144378.27810860984, 19906.90046549787, 20053.197872084955, 20300.492487687632, 20745.273915412887, 21569.460763480725, 41006.794966025576, 41009.794951025055, 41268.0, 41387.37918931218, 41563.376549351786, 11195.832062519068, 11292.153088518395, 11436.256643318158, 11594.18840681161, 11613.245139065933, 9517.476538790434, 9672.371295865747, 9697.127258546765, 9708.902910970799, 9881.604735810632, 10577.57689692419, 10607.893921060844, 11216.102711783202, 11306.095512358992, 11413.771724565462, 3660.4692319613505, 3920.4119382092913, 4057.208844275397, 4062.614051665087, 4137.8758637240935, 958.7363475044418, 959.8464245720651, 969.132626299458, 975.2685485885586, 981.1365997921926, 18330.816691833177, 18412.4508951332, 18810.059497025093, 18862.056897155362, 19109.33117340914, 1005.2711783956719, 1013.8377859542438, 1014.9289549731595, 1015.1878497202209, 1027.866377370937, 10393.0, 10470.371777693363, 10497.16022718196, 10621.362718236931, 10737.731556711145, 437161.0, 441921.0, 454852.0, 456319.0, 458885.0, 108487.45756271169, 113684.0, 116804.0, 117812.41093794476, 119632.40183799026, 1128.7178205448638, 1145.1983611472003, 1146.2320245435412, 1149.2989276541302, 1152.2970987697497, 16903.577410564834, 17108.657826843144, 17208.483745487654, 17210.827891721423, 17286.394976175772, 55778.0, 56423.71788141033, 56463.0, 57564.136537951126, 57658.7117064412, 71782.28217717756, 71891.28108718846, 72134.63932680304, 72291.27708722846, 73737.0, 18869.528261793566, 19069.809301906804, 19200.519987000436, 19399.4180174595, 19430.514237144183, 21489.925503725062, 21527.354179374644, 21588.46028849291, 21812.454688632275, 22021.669674954566, 17061.57346066358, 17117.400890968755, 17307.3942412015, 17465.0, 18078.728819067463, 15114.622134446727, 15335.386584536494, 15683.607909802346, 16545.91727041405, 16793.580160496087, 17213.65572688564, 17439.82560174382, 17713.822861771216, 17810.465686029438, 18112.0, 19010.049497524793, 19027.71458428097, 19110.617787643892, 19158.32945846889, 19302.903485482482, 17338.566535836704, 17382.217800199276, 17407.651846962737, 17464.82535174683, 17551.82448175502], "value": 12531.765414393243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.9608811735648, 1391.311300906051, 1403.95086171984, 1404.950826721065, 1405.9086159399637, 14710.63223419415, 15231.84768152318, 15267.694646107086, 15367.308471118798, 15376.0, 15142.470013549528, 15157.242137893089, 15169.620759481018, 15229.086254824719, 15280.923595382008, 2666.3334166458385, 2702.1083042595897, 2744.2727677165567, 2758.3104223944015, 2763.198672385016, 2683.7047924728263, 2757.4347258811995, 2761.8619069046567, 2782.9025984090563, 2789.4560560690675, 2612.830166039211, 2786.2755683522328, 2795.7903157263186, 2800.3979144483933, 2803.327201471642, 2781.5271403861293, 2789.316617428743, 2809.592609071673, 2832.34855983124, 2856.742893139617, 2763.69599344072, 2768.0726956469607, 2779.555271156605, 2786.3730660601404, 2800.187945495804, 14755.926220368936, 14940.850591494054, 15059.096454212782, 15098.622534436618, 15105.39578416862, 7888.0, 8093.0, 8158.061822890325, 8169.468984515987, 8174.6730130794695, 5104.05574968632, 5114.43741188469, 5215.16557350822, 5284.445133260991, 5389.272448219479, 1749.4314347836876, 1834.7431359609666, 1908.4370110817204, 1947.474181970874, 1960.3334866145578, 25825.870870645715, 26687.0, 26872.59691104635, 26937.24907881001, 26970.865145674343, 6574.211094668671, 6652.534322597372, 6692.698828552727, 6903.930960690429, 6907.551009184387, 16923.746143807854, 16967.66064678724, 16968.23642936071, 17023.48929532116, 17054.317827287017, 7680.615969201517, 7773.922260777433, 7832.334251588565, 7862.606869656494, 7880.133185349607, 7166.749163779243, 7270.091238595176, 7292.854142917112, 7383.372413344926, 7441.181470038291, 5096.898062038738, 5144.536991670768, 5212.55693266069, 5268.736563171826, 5411.567074634098, 1452.8837692984537, 1463.0709499467914, 1466.3767898643034, 1469.3461409672593, 1474.8598883106088, 874.2175752701423, 877.6182360673, 897.6588896219395, 898.0974121008345, 905.7916679163698, 7267.30960558746, 7346.449016323797, 7411.59236242001, 7421.183669796318, 7421.925780742232, 662.1888186970922, 671.0906721392442, 672.6670298202421, 675.2437270257343, 683.4293365040148, 4725.36207611968, 5129.538341549204, 5133.743312834344, 5146.639735218574, 5155.7679904404395, 21088.578228435344, 21737.456563586038, 21755.891220543795, 21830.89084554567, 21970.89014554917, 20380.0, 21316.680249796267, 21318.680219796715, 21355.46611334729, 21664.675029874565, 10679.466026698634, 10851.0, 10981.066609338135, 11058.0, 11092.944535277273, 8045.798855028437, 8103.108658047492, 8163.673453061811, 8166.959165204374, 8208.179182081984, 17090.48728538146, 17968.371107011193, 17979.370722024665, 18120.818791812442, 18490.260389584804, 18828.717569236745, 18865.15106820169, 19473.318433854747, 19551.804481954998, 19651.901740491205, 10229.693109206735, 10717.839232411365, 10823.080038196842, 10943.616973405893, 10946.835797462885, 13506.72986540244, 13599.0, 13651.658708532366, 13752.0, 13778.311084445939, 10126.645567405105, 10284.537195826057, 10463.58145674195, 10618.469076546296, 10654.946725266323, 10464.424456654957, 10482.318649287772, 10493.370397776158, 10513.158947284046, 10632.096271816672, 9703.12671859536, 9810.460424676712, 9883.357581757164, 9903.752406189902, 9918.950405247928, 6980.6509674515055, 7191.748288810076, 7232.63836808168, 7243.782686519413, 7250.854982900418, 7028.9297107030325, 7073.71705131789, 7238.746643867439, 7261.38278246355, 7305.671244793891], "value": 6526.44980629245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.32278037208874, 508.5880436846155, 521.4785214785214, 525.6005435868739, 534.8368747532003, 6279.246490421145, 6284.654344011077, 6289.339619339972, 6337.461315788152, 6345.968270158654, 6159.168512250845, 6185.4433101020895, 6218.657973811439, 6232.813015609528, 6243.0, 5108.058937603715, 5114.769835357418, 5131.435542090367, 5157.767900444489, 5175.482451754813, 5102.744862756866, 5119.513646203604, 5122.871928201787, 5141.871453213662, 5152.381714194302, 4711.528847115295, 4813.831515896944, 4984.925226121611, 5093.974530127344, 5098.949010509903, 4829.034193161364, 4833.613310935117, 4870.172070747982, 4872.585830204437, 4882.877928051792, 4302.720323178984, 4352.586504282088, 4363.454568178978, 4365.170617582649, 4390.604845563915, 5880.323762767251, 6069.908951365733, 6078.452939235446, 6102.589477156498, 6112.63324200545, 5465.6447330923365, 5497.670139791625, 5497.670139791625, 5558.722063896829, 5582.553395728332, 6492.7402903883785, 6497.278221271366, 6524.543281970264, 6526.706298216592, 6533.150690410263, 4525.841595544141, 4670.136024835382, 4707.929381059287, 4766.809327626891, 4774.928376074362, 6557.803265902031, 6703.363180497845, 6759.188897332253, 6781.932180678179, 6826.795196144124, 4816.133096042676, 4817.518248175154, 4820.373351464357, 4824.614030877521, 4845.079434907427, 4881.975590122027, 4927.28554359623, 4938.38270216223, 4959.70241785494, 4966.925496117561, 5487.286652735119, 5519.254900588449, 5565.16522521625, 5586.91619625706, 5601.887962240814, 6537.542372033912, 6569.211694596679, 6578.8355291118105, 6614.677064587102, 6625.734970601218, 1704.9173774653184, 1708.2056843567552, 1719.2864961041278, 1721.7073097573443, 1725.3788636090997, 1130.3331034689572, 1181.6100686773343, 1191.9570375921069, 1193.4689063366893, 1198.7542553776454, 5555.333359996826, 5573.860653483695, 5591.664500130005, 5638.718064096779, 5653.717314134359, 6535.22253042455, 6586.176727909012, 6605.8348541285895, 6676.332366763382, 6692.397684208445, 5602.915956260659, 5652.236948012048, 5662.094064949671, 5683.0, 5684.232628595169, 3496.5629296337956, 3504.649535046526, 3538.9469157962653, 3542.3623747725655, 3555.5022296878456, 6344.6827658616885, 6362.618242905441, 6396.1045453636525, 6454.4513716333695, 6472.255690595642, 6652.27472615337, 6664.133662623828, 6844.5208835382045, 6862.245153033163, 6896.379325860697, 6240.28236752761, 6305.747770089237, 6337.809865704036, 6358.968205158944, 6376.1392212051705, 6480.902786458301, 6560.9343906562235, 6573.80278591643, 6597.208334999831, 6599.307072757291, 6005.330059293398, 6449.7420103195345, 6480.708368123352, 6541.8691626168165, 6554.0, 6312.506559908902, 6338.58799178052, 6380.266269379081, 6433.517486188648, 6457.838554036187, 4800.711957282435, 4812.0, 4825.324454576432, 4833.0, 4862.4651288357545, 6426.646534440463, 6457.225132984072, 6552.803415897531, 6637.38701602401, 6729.1924969002075, 6396.616203027833, 6441.581297215666, 6445.774397896051, 6457.6771161442675, 6530.706118224786, 6353.523485738496, 6395.040743888454, 6395.168628078506, 6423.710933008119, 6463.482921366185, 6223.159873417212, 6349.238091429058, 6352.428281454691, 6381.521385895983, 6397.264314603694, 6420.6147631142285, 6454.451371633276, 6475.967620161869, 6481.837954051187, 6513.5018945643715, 6183.628982261079, 6185.195924529782, 6261.592996455216, 6284.151639528605, 6302.65335406557], "value": 4977.360803012157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.7694399456142, 918.4994178172896, 923.6443969071905, 926.305271046715, 931.0410277414261, 19323.420297391083, 20200.19199232031, 20281.898590507044, 20296.59406811863, 20339.49151271219, 18278.90860545699, 18305.267789288446, 18372.44882653519, 18397.356092536764, 18450.261989520437, 929.7396728915897, 944.6976967370445, 945.6170251048336, 949.3544389814923, 950.8668786369914, 942.528735632184, 947.8909675679472, 947.943123412594, 948.3693343926316, 948.6632245552833, 977.0815433492494, 997.9251556133282, 1002.6791426743445, 1003.8594596756424, 1012.084063922148, 984.8325784616633, 986.2061040862139, 990.88604810447, 991.7272749993738, 997.062761004657, 732.179958446538, 734.4528326396869, 735.6358602491747, 736.3556887723242, 738.6122285799944, 19152.329668461538, 19672.213111475525, 19699.704504432302, 19753.901230493757, 20083.0, 21726.89136554307, 21912.45218869525, 22000.669989950162, 22143.114275428965, 22236.221732239293, 17217.91391043037, 17418.825811741975, 17618.119094045247, 17628.91185544077, 17633.294668213384, 3557.7153827693724, 3594.3530164570366, 3600.279944011182, 3605.134767655744, 3608.4226523756333, 102303.0, 103122.48438757833, 141554.0, 144674.27662861723, 145669.27165364212, 16977.0, 17013.659726805643, 17089.0, 17393.130343482775, 17498.0, 31771.84114079415, 31811.68188318087, 31824.84087579547, 31967.200819979687, 32046.359072818414, 8507.53208573522, 8762.824743505222, 8768.342374321952, 8799.340049496313, 8826.514541700268, 4130.0, 4172.186423647359, 4196.916061678749, 4222.218889505451, 4240.915181696349, 5260.763265653055, 5289.629725919149, 5368.570514358842, 5377.3816011159215, 5412.296401467784, 1043.2488608202082, 1070.5075665193942, 1077.8113830079863, 1080.1197024425069, 1080.9567617295377, 689.9793006209821, 705.2911823617231, 711.1253158614829, 720.218562859293, 720.945929055323, 11321.660350189508, 11567.76864462706, 11893.940530297294, 12375.876241237653, 12410.627681169579, 653.6992983227768, 661.798151563768, 665.2216906219735, 669.6885948034187, 681.1077488490093, 5424.837254882281, 5448.818427456112, 5458.372287186945, 5500.862478438071, 5535.667859928417, 114938.42530787292, 116323.0, 118571.40714296373, 119564.0, 120010.39994800145, 108351.12419940963, 108827.45586272018, 111029.0, 111159.0, 112764.0, 91269.0, 97997.0, 98418.50790746, 98544.0, 100588.4970575157, 9995.900040999788, 10111.7472063199, 10160.796784064425, 10260.12788912921, 10263.332883362558, 44615.33077003912, 44664.55335446734, 45260.0, 45829.54170458253, 46304.768476157406, 57043.71478142583, 57770.711146444, 58228.41771582399, 58431.0, 59731.402685972585, 15116.622084447978, 15281.46514871974, 15391.61520961985, 15508.92245538765, 15607.843921561092, 14655.853441465875, 14770.187639679922, 14779.852201477848, 14825.0, 14855.851441485447, 14289.428422863384, 14311.499097531536, 14349.139051656934, 14453.4941277059, 14566.271686415424, 15010.0, 15079.698406031599, 15178.392864285304, 15398.692026159639, 15485.84514154844, 13500.5274815381, 13819.723605527632, 13861.792073119113, 13890.722185556435, 13893.0, 10010.0, 10110.545025474019, 10247.48762561854, 10257.17942564608, 10312.793744124925, 10853.457327133454, 10914.181436392144, 10960.28758130719, 10965.945170274097, 11145.609903653658], "value": 8716.314109219413, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 113.0, 116.0, 115.0, 113.0, 115.0, 109.0, 117.0, 112.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 130.0, 123.0, 115.0, 126.0, 126.0, 122.0, 124.0, 122.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 166.0, 163.0, 176.0, 172.0, 167.0, 169.0, 165.0, 162.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 74.0, 78.0, 79.0, 80.0, 81.0, 79.0, 82.0, 74.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 85.0, 86.0, 86.0, 90.0, 81.0, 82.0, 81.0, 79.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 118.0, 127.0, 115.0, 114.0, 118.0, 117.0, 115.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 155.0, 148.0, 148.0, 152.0, 153.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 99.0, 95.0, 95.0, 95.0, 99.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 51.0, 55.0, 54.0, 54.0, 56.0, 53.0, 56.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 47.0, 48.0, 42.0, 42.0, 38.0, 40.0, 37.0, 43.0, 45.0], "value": 41.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 81.0, 77.0, 82.0, 76.0, 76.0, 80.0, 75.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 139.0, 116.0, 123.0, 130.0, 122.0, 125.0, 125.0, 123.0, 117.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 175.0, 177.0, 177.0, 172.0, 169.0, 180.0, 167.0, 169.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 66.0, 68.0, 64.0, 65.0, 66.0, 64.0, 69.0], "value": 65.3, "unit": "score"}]}]} 02:26:19 INFO - Return code: 0 02:26:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:26:19 INFO - # TBPL SUCCESS # 02:26:19 INFO - Running post-action listener: _package_coverage_data 02:26:19 INFO - Running post-action listener: _resource_record_post_action 02:26:19 INFO - [mozharness: 2017-09-10 09:26:19.821079Z] Finished run-tests step (success) 02:26:19 INFO - Running post-run listener: _resource_record_post_run 02:26:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8732672; Write bytes: 306364416; Read time: 7228; Write time: 210420 02:26:19 INFO - TinderboxPrint: CPU usage
13.3% 02:26:19 INFO - TinderboxPrint: I/O read bytes / time
8,732,672 / 7,228 02:26:19 INFO - TinderboxPrint: I/O write bytes / time
306,364,416 / 210,420 02:26:19 INFO - TinderboxPrint: CPU idle
8,250.4 (86.7%) 02:26:19 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 02:26:19 INFO - TinderboxPrint: Swap in / out
0 / 0 02:26:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12591104; Read time: 0; Write time: 1220 02:26:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:26:19 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8732672; Write bytes: 293773312; Read time: 7228; Write time: 209200 02:26:20 INFO - Running post-run listener: _upload_blobber_files 02:26:20 INFO - Blob upload gear active. 02:26:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:20 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 02:26:20 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'] 02:26:20 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 02:26:20 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:21 INFO - (blobuploader) - INFO - Done attempting. 02:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:22 INFO - (blobuploader) - INFO - Done attempting. 02:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:26:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:29 INFO - (blobuploader) - INFO - Done attempting. 02:26:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:26:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:30 INFO - (blobuploader) - INFO - Done attempting. 02:26:30 INFO - (blobuploader) - INFO - Iteration through files over. 02:26:30 INFO - Return code: 0 02:26:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:26:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:26:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a96114f1adcedb0a91485d9974526672c0b93d07975ec04ab0f02ecab9502cf0528b4f1c950fd3efb5d8b29f58b8677be020e5c3f73e3ae8a634f31f0e799ca", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a338378225b8a3dd4d9626346a668427aa046b7f8d9e32ce0b1fb72a115ca72d871ce71de66654fba8fff71b625b1d9204d824ac53ecdf838b52a00d39717a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04c55da4564f111061abb2cbc305d6fa8676f7d72336adfb1fcf85730229e44cca2fff12f3f1347fea3bf8f659155369503d86573c704e813f01989294fb1e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdabeb0c089bfbafd01b7becc81ced7acf476eae5d23a7292238a2fa09d1504c30f61c8b686d827787bb8dffa10f697e25bf18d26af8f8dac1238889c795f9a6"} 02:26:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:26:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:26:30 INFO - Contents: 02:26:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a96114f1adcedb0a91485d9974526672c0b93d07975ec04ab0f02ecab9502cf0528b4f1c950fd3efb5d8b29f58b8677be020e5c3f73e3ae8a634f31f0e799ca", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a338378225b8a3dd4d9626346a668427aa046b7f8d9e32ce0b1fb72a115ca72d871ce71de66654fba8fff71b625b1d9204d824ac53ecdf838b52a00d39717a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04c55da4564f111061abb2cbc305d6fa8676f7d72336adfb1fcf85730229e44cca2fff12f3f1347fea3bf8f659155369503d86573c704e813f01989294fb1e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdabeb0c089bfbafd01b7becc81ced7acf476eae5d23a7292238a2fa09d1504c30f61c8b686d827787bb8dffa10f697e25bf18d26af8f8dac1238889c795f9a6"} 02:26:30 INFO - Running post-run listener: copy_logs_to_upload_dir 02:26:30 INFO - Copying logs to upload dir... 02:26:30 INFO - mkdir: /builds/slave/test/build/upload/logs 02:26:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.645719 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-10 02:26:31.028155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 02:26:31.032272) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a96114f1adcedb0a91485d9974526672c0b93d07975ec04ab0f02ecab9502cf0528b4f1c950fd3efb5d8b29f58b8677be020e5c3f73e3ae8a634f31f0e799ca", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a338378225b8a3dd4d9626346a668427aa046b7f8d9e32ce0b1fb72a115ca72d871ce71de66654fba8fff71b625b1d9204d824ac53ecdf838b52a00d39717a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04c55da4564f111061abb2cbc305d6fa8676f7d72336adfb1fcf85730229e44cca2fff12f3f1347fea3bf8f659155369503d86573c704e813f01989294fb1e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdabeb0c089bfbafd01b7becc81ced7acf476eae5d23a7292238a2fa09d1504c30f61c8b686d827787bb8dffa10f697e25bf18d26af8f8dac1238889c795f9a6"} build_url:https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/W1NZUJsyQSiI_HuWC54dMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a96114f1adcedb0a91485d9974526672c0b93d07975ec04ab0f02ecab9502cf0528b4f1c950fd3efb5d8b29f58b8677be020e5c3f73e3ae8a634f31f0e799ca", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a338378225b8a3dd4d9626346a668427aa046b7f8d9e32ce0b1fb72a115ca72d871ce71de66654fba8fff71b625b1d9204d824ac53ecdf838b52a00d39717a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04c55da4564f111061abb2cbc305d6fa8676f7d72336adfb1fcf85730229e44cca2fff12f3f1347fea3bf8f659155369503d86573c704e813f01989294fb1e13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdabeb0c089bfbafd01b7becc81ced7acf476eae5d23a7292238a2fa09d1504c30f61c8b686d827787bb8dffa10f697e25bf18d26af8f8dac1238889c795f9a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 02:26:31.064677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:26:31.065046) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1505034344.537200-1253637084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 02:26:31.149688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 02:26:31.149997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 02:26:31.150288) ========= ========= Total master_lag: 0.21 =========