builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1505555186.62 results: success (0) revision: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.618970) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.620001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.620272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.685779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.689065) ========= 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=dac658600622fd96716c9acf000001b3-1505546407.535171-7488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 02:46:26-- 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% 36.4M=0s 2017-09-16 02:46:26 (36.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090877 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.805891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.806239) ========= 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=dac658600622fd96716c9acf000001b3-1505546407.535171-7488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020242 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:26.864639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-16 02:46:26.868007) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 --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 c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 --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=dac658600622fd96716c9acf000001b3-1505546407.535171-7488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 02:46:26,900 truncating revision to first 12 chars 2017-09-16 02:46:26,900 Setting DEBUG logging. 2017-09-16 02:46:26,900 attempt 1/10 2017-09-16 02:46:26,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c99a1520c7a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 02:46:27,356 attempt 1/10 2017-09-16 02:46:28,283 current task status: no status available at this point. state: STARTED 2017-09-16 02:46:28,284 sleeping for 11.00s (attempt 1/10) 2017-09-16 02:46:39,295 attempt 2/10 2017-09-16 02:46:39,794 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-16 02:46:39,979 unpacking tar archive at: mozilla-central-c99a1520c7a5/testing/mozharness/ program finished with exit code 0 elapsedTime=13.388703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-16 02:46:40.272692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:40.276013) ========= script_repo_revision: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:40.276385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:40.276662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 02:46:40.290183) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-16 02:46:40.290492) ========= /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=dac658600622fd96716c9acf000001b3-1505546407.535171-7488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:46:40 INFO - MultiFileLogger online at 20170916 02:46:40 in /builds/slave/test 02:46:40 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:46:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:46:40 INFO - {'append_to_log': False, 02:46:40 INFO - 'base_work_dir': '/builds/slave/test', 02:46:40 INFO - 'blob_upload_branch': 'Firefox', 02:46:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:46:40 INFO - 'branch': 'Firefox', 02:46:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:46:40 INFO - 'code_coverage': False, 02:46:40 INFO - 'config_files': ('talos/linux_config.py',), 02:46:40 INFO - 'default_actions': ('clobber', 02:46:40 INFO - 'read-buildbot-config', 02:46:40 INFO - 'download-and-extract', 02:46:40 INFO - 'populate-webroot', 02:46:40 INFO - 'create-virtualenv', 02:46:40 INFO - 'install', 02:46:40 INFO - 'setup-mitmproxy', 02:46:40 INFO - 'run-tests'), 02:46:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:46:40 INFO - 'disable_ccov_upload': False, 02:46:40 INFO - 'disable_stylo': False, 02:46:40 INFO - 'download_minidump_stackwalk': True, 02:46:40 INFO - 'download_symbols': 'ondemand', 02:46:40 INFO - 'enable_stylo': False, 02:46:40 INFO - 'enable_webrender': False, 02:46:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:46:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:46:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:46:40 INFO - 'gecko_profile': False, 02:46:40 INFO - 'gecko_profile_interval': 0, 02:46:40 INFO - 'installer_path': 'installer.exe', 02:46:40 INFO - 'log_level': 'info', 02:46:40 INFO - 'log_name': 'talos', 02:46:40 INFO - 'log_to_console': True, 02:46:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:46:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:46:40 INFO - 'opt_config_files': (), 02:46:40 INFO - 'pip_index': False, 02:46:40 INFO - 'suite': 'dromaeojs-e10s', 02:46:40 INFO - 'system_bits': '32', 02:46:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:46:40 INFO - 'title': 'talos-linux64-ix-078', 02:46:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:46:40 INFO - 'use_talos_json': True, 02:46:40 INFO - 'verify': 'False', 02:46:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:46:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:46:40 INFO - 'work_dir': 'build'} 02:46:40 INFO - [mozharness: 2017-09-16 09:46:40.461581Z] Running clobber step. 02:46:40 INFO - Running pre-action listener: _resource_record_pre_action 02:46:40 INFO - Running main action method: clobber 02:46:40 INFO - rmtree: /builds/slave/test/build 02:46:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:46:41 INFO - Running post-action listener: _resource_record_post_action 02:46:41 INFO - [mozharness: 2017-09-16 09:46:41.973588Z] Finished clobber step (success) 02:46:41 INFO - [mozharness: 2017-09-16 09:46:41.973687Z] Running read-buildbot-config step. 02:46:41 INFO - Running pre-action listener: _resource_record_pre_action 02:46:41 INFO - Running main action method: read_buildbot_config 02:46:41 INFO - Using buildbot properties: 02:46:41 INFO - { 02:46:41 INFO - "project": "", 02:46:41 INFO - "product": "firefox", 02:46:41 INFO - "who": "archaeopteryx@coole-files.de", 02:46:41 INFO - "installer_path": "public/build/target.tar.bz2", 02:46:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:46:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:46:41 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:46:41 INFO - "stage_platform": "linux64-qr", 02:46:41 INFO - "basedir": "/builds/slave/test", 02:46:41 INFO - "buildnumber": 61, 02:46:41 INFO - "platform": "ubuntu64_hw_qr", 02:46:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:46:41 INFO - "slavebuilddir": "test", 02:46:41 INFO - "taskId": "Z4gywlb2QKurQOYw24nTeQ", 02:46:41 INFO - "branch": "mozilla-central", 02:46:41 INFO - "script_repo_revision": "production", 02:46:41 INFO - "revision": "c99a1520c7a5af8f3769d3a4fce38697ce47cbb2", 02:46:41 INFO - "slavename": "talos-linux64-ix-078", 02:46:41 INFO - "repo_path": "mozilla-central" 02:46:41 INFO - } 02:46:41 INFO - Finding installer, test and symbols from parent task. 02:46:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4gywlb2QKurQOYw24nTeQ'}, attempt #1 02:46:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4gywlb2QKurQOYw24nTeQ'}, attempt #1 02:46:42 INFO - Task dependencies: V7UvXOTwSFSG24DAmofqJA 02:46:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA'}, attempt #1 02:46:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2 02:46:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.test_packages.json 02:46:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.crashreporter-symbols.zip 02:46:43 INFO - Running post-action listener: _resource_record_post_action 02:46:43 INFO - [mozharness: 2017-09-16 09:46:43.364032Z] Finished read-buildbot-config step (success) 02:46:43 INFO - [mozharness: 2017-09-16 09:46:43.364228Z] Running download-and-extract step. 02:46:43 INFO - Running pre-action listener: _resource_record_pre_action 02:46:43 INFO - Running main action method: download_and_extract 02:46:43 INFO - mkdir: /builds/slave/test/build/tests 02:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:43 INFO - trying https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.test_packages.json 02:46:43 INFO - Downloading https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:46:44 INFO - Downloaded 989 bytes. 02:46:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:46:44 INFO - Using the following test package requirements: 02:46:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:46:44 INFO - u'common': [u'target.common.tests.zip'], 02:46:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:46:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:46:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:46:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:46:44 INFO - u'mozbase': [u'target.common.tests.zip'], 02:46:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:46:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:46:44 INFO - u'web-platform': [u'target.common.tests.zip', 02:46:44 INFO - u'target.web-platform.tests.tar.gz'], 02:46:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:46:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:46:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.common.tests.zip 02:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:46:44 INFO - Fetch https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.common.tests.zip into memory 02:46:45 INFO - Content-Length response header: 54734781 02:46:45 INFO - Bytes received: 54734781 02:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.talos.tests.zip 02:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.talos.tests.zip into memory 02:46:57 INFO - Content-Length response header: 14508749 02:46:57 INFO - Bytes received: 14508749 02:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:57 INFO - trying https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2 02:46:57 INFO - Downloading https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:46:58 INFO - Downloaded 61402190 bytes. 02:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2 02:46:59 INFO - mkdir: /builds/slave/test/properties 02:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:59 INFO - Contents: 02:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2 02:46:59 INFO - Running post-action listener: _resource_record_post_action 02:46:59 INFO - Running post-action listener: find_tests_for_verification 02:46:59 INFO - Running post-action listener: set_extra_try_arguments 02:46:59 INFO - [mozharness: 2017-09-16 09:46:59.024717Z] Finished download-and-extract step (success) 02:46:59 INFO - [mozharness: 2017-09-16 09:46:59.024948Z] Running populate-webroot step. 02:46:59 INFO - Running pre-action listener: _resource_record_pre_action 02:46:59 INFO - Running main action method: populate_webroot 02:46:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:59 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['tresize', 02:46:59 INFO - 'tcanvasmark']}, 02:46:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:59 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['dromaeo_css', 02:46:59 INFO - 'kraken']}, 02:46:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:59 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'tests': ['damp', 'tps']}, 02:46:59 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['damp', 'tps']}, 02:46:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:59 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['dromaeo_dom']}, 02:46:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:46:59 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['basic_compositor_video', 02:46:59 INFO - 'glvideo']}, 02:46:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:46:59 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['ts_paint_webext', 02:46:59 INFO - 'tp5o_webext']}, 02:46:59 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:59 INFO - 'ts_paint', 02:46:59 INFO - 'tpaint', 02:46:59 INFO - 'sessionrestore', 02:46:59 INFO - 'sessionrestore_many_windows', 02:46:59 INFO - 'sessionrestore_no_auto_restore', 02:46:59 INFO - 'tabpaint']}, 02:46:59 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['a11yr', 02:46:59 INFO - 'ts_paint', 02:46:59 INFO - 'tpaint', 02:46:59 INFO - 'sessionrestore', 02:46:59 INFO - 'sessionrestore_many_windows', 02:46:59 INFO - 'sessionrestore_no_auto_restore', 02:46:59 INFO - 'tabpaint']}, 02:46:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:46:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 02:46:59 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['perf_reftest_singletons']}, 02:46:59 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['bloom_basic']}, 02:46:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:59 INFO - 'tsvgr_opacity', 02:46:59 INFO - 'tart', 02:46:59 INFO - 'tscrollx', 02:46:59 INFO - 'tsvg_static']}, 02:46:59 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['tsvgx', 02:46:59 INFO - 'tsvgr_opacity', 02:46:59 INFO - 'tart', 02:46:59 INFO - 'tscrollx', 02:46:59 INFO - 'tsvg_static']}, 02:46:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:59 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'talos_options': ['--disable-stylo'], 02:46:59 INFO - 'tests': ['tp5o']}, 02:46:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:59 INFO - 'talos_options': ['--mitmproxy', 02:46:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:59 INFO - '--firstNonBlankPaint'], 02:46:59 INFO - 'tests': ['tp6_google', 02:46:59 INFO - 'tp6_youtube', 02:46:59 INFO - 'tp6_amazon', 02:46:59 INFO - 'tp6_facebook']}, 02:46:59 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:59 INFO - 'talos_options': ['--disable-stylo', 02:46:59 INFO - '--mitmproxy', 02:46:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:59 INFO - '--firstNonBlankPaint'], 02:46:59 INFO - 'tests': ['tp6_google', 02:46:59 INFO - 'tp6_youtube', 02:46:59 INFO - 'tp6_amazon', 02:46:59 INFO - 'tp6_facebook']}, 02:46:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:59 INFO - 'talos_options': ['--stylo-threads=1', 02:46:59 INFO - '--mitmproxy', 02:46:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:59 INFO - '--firstNonBlankPaint'], 02:46:59 INFO - 'tests': ['tp6_google', 02:46:59 INFO - 'tp6_youtube', 02:46:59 INFO - 'tp6_amazon', 02:46:59 INFO - 'tp6_facebook']}, 02:46:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'talos_options': ['--xperf_path', 02:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:59 INFO - 'tests': ['tp5n']}, 02:46:59 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:46:59 INFO - 'talos_options': ['--disable-stylo', 02:46:59 INFO - '--xperf_path', 02:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:59 INFO - 'tests': ['tp5n']}}} 02:46:59 INFO - Running post-action listener: _resource_record_post_action 02:46:59 INFO - [mozharness: 2017-09-16 09:46:59.043728Z] Finished populate-webroot step (success) 02:46:59 INFO - [mozharness: 2017-09-16 09:46:59.043818Z] Running create-virtualenv step. 02:46:59 INFO - Running pre-action listener: _resource_record_pre_action 02:46:59 INFO - Running main action method: create_virtualenv 02:46:59 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:59 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:46:59 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:46:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:46:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:59 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:59 INFO - Installing pip...............done. 02:46:59 INFO - Return code: 0 02:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:47:00 INFO - Reading from file tmpfile_stdout 02:47:00 INFO - Output received: 02:47:00 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:47:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:47:00 INFO - Using env: {'DISPLAY': ':0', 02:47:00 INFO - 'HOME': '/home/cltbld', 02:47:00 INFO - 'LANG': 'en_US.UTF-8', 02:47:00 INFO - 'LANGUAGE': 'en_US:en', 02:47:00 INFO - 'LOGNAME': 'cltbld', 02:47:00 INFO - 'MAIL': '/var/mail/cltbld', 02:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:00 INFO - 'MOZ_NO_REMOTE': '1', 02:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:00 INFO - 'NO_EM_RESTART': '1', 02:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:00 INFO - 'PWD': '/builds/slave/test', 02:47:00 INFO - 'SHELL': '/bin/bash', 02:47:00 INFO - 'SHLVL': '1', 02:47:00 INFO - 'TERM': 'linux', 02:47:00 INFO - 'TMOUT': '86400', 02:47:00 INFO - 'USER': 'cltbld', 02:47:00 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:00 INFO - '_': '/tools/buildbot/bin/python'} 02:47:01 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:47:01 INFO - Downloading/unpacking pip>=1.5 02:47:01 INFO - Running setup.py egg_info for package pip 02:47:01 INFO - warning: no files found matching 'pip/cacert.pem' 02:47:01 INFO - warning: no files found matching '*.html' under directory 'docs' 02:47:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:47:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:47:01 INFO - Installing collected packages: pip 02:47:01 INFO - Found existing installation: pip 1.1 02:47:01 INFO - Uninstalling pip: 02:47:01 INFO - Successfully uninstalled pip 02:47:01 INFO - Running setup.py install for pip 02:47:01 INFO - warning: no files found matching 'pip/cacert.pem' 02:47:01 INFO - warning: no files found matching '*.html' under directory 'docs' 02:47:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:47:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:47:01 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:47:01 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:47:01 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:47:01 INFO - Successfully installed pip 02:47:01 INFO - Cleaning up... 02:47:01 INFO - Return code: 0 02:47:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:01 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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:01 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:47:01 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:47:01 INFO - Using env: {'DISPLAY': ':0', 02:47:01 INFO - 'HOME': '/home/cltbld', 02:47:01 INFO - 'LANG': 'en_US.UTF-8', 02:47:01 INFO - 'LANGUAGE': 'en_US:en', 02:47:01 INFO - 'LOGNAME': 'cltbld', 02:47:01 INFO - 'MAIL': '/var/mail/cltbld', 02:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:01 INFO - 'MOZ_NO_REMOTE': '1', 02:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:01 INFO - 'NO_EM_RESTART': '1', 02:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:01 INFO - 'PWD': '/builds/slave/test', 02:47:01 INFO - 'SHELL': '/bin/bash', 02:47:01 INFO - 'SHLVL': '1', 02:47:01 INFO - 'TERM': 'linux', 02:47:01 INFO - 'TMOUT': '86400', 02:47:01 INFO - 'USER': 'cltbld', 02:47:01 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:01 INFO - '_': '/tools/buildbot/bin/python'} 02:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:01 INFO - Downloading/unpacking psutil>=3.1.1 02:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:02 INFO - Installing collected packages: psutil 02:47:02 INFO - Running setup.py install for psutil 02:47:02 INFO - building 'psutil._psutil_linux' extension 02:47:02 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:47:02 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:47:02 INFO - building 'psutil._psutil_posix' extension 02:47:02 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:47:03 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:47:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:03 INFO - Successfully installed psutil 02:47:03 INFO - Cleaning up... 02:47:03 INFO - Return code: 0 02:47:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:03 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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:03 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:47:03 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:47:03 INFO - Using env: {'DISPLAY': ':0', 02:47:03 INFO - 'HOME': '/home/cltbld', 02:47:03 INFO - 'LANG': 'en_US.UTF-8', 02:47:03 INFO - 'LANGUAGE': 'en_US:en', 02:47:03 INFO - 'LOGNAME': 'cltbld', 02:47:03 INFO - 'MAIL': '/var/mail/cltbld', 02:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:03 INFO - 'MOZ_NO_REMOTE': '1', 02:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:03 INFO - 'NO_EM_RESTART': '1', 02:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:03 INFO - 'PWD': '/builds/slave/test', 02:47:03 INFO - 'SHELL': '/bin/bash', 02:47:03 INFO - 'SHLVL': '1', 02:47:03 INFO - 'TERM': 'linux', 02:47:03 INFO - 'TMOUT': '86400', 02:47:03 INFO - 'USER': 'cltbld', 02:47:03 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:03 INFO - '_': '/tools/buildbot/bin/python'} 02:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:47:03 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:47:03 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:47:03 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:47:03 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:47:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:47:04 INFO - Installing collected packages: mozsystemmonitor 02:47:04 INFO - Running setup.py install for mozsystemmonitor 02:47:05 INFO - Successfully installed mozsystemmonitor 02:47:05 INFO - Cleaning up... 02:47:06 INFO - Return code: 0 02:47:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:47: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:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47: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:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:47:06 INFO - Using env: {'DISPLAY': ':0', 02:47:06 INFO - 'HOME': '/home/cltbld', 02:47:06 INFO - 'LANG': 'en_US.UTF-8', 02:47:06 INFO - 'LANGUAGE': 'en_US:en', 02:47:06 INFO - 'LOGNAME': 'cltbld', 02:47:06 INFO - 'MAIL': '/var/mail/cltbld', 02:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:06 INFO - 'MOZ_NO_REMOTE': '1', 02:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:06 INFO - 'NO_EM_RESTART': '1', 02:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:06 INFO - 'PWD': '/builds/slave/test', 02:47:06 INFO - 'SHELL': '/bin/bash', 02:47:06 INFO - 'SHLVL': '1', 02:47:06 INFO - 'TERM': 'linux', 02:47:06 INFO - 'TMOUT': '86400', 02:47:06 INFO - 'USER': 'cltbld', 02:47:06 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:06 INFO - '_': '/tools/buildbot/bin/python'} 02:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:47: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:47: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:47: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:47: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:47:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:47:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:47:07 INFO - warning: no files found matching '*.txt' 02:47:07 INFO - no previously-included directories found matching 'build' 02:47:07 INFO - no previously-included directories found matching 'dist' 02:47:07 INFO - no previously-included directories found matching '.git*' 02:47:07 INFO - Installing collected packages: jsonschema, functools32 02:47:07 INFO - Running setup.py install for functools32 02:47:08 INFO - warning: no files found matching '*.txt' 02:47:08 INFO - no previously-included directories found matching 'build' 02:47:08 INFO - no previously-included directories found matching 'dist' 02:47:08 INFO - no previously-included directories found matching '.git*' 02:47:08 INFO - Successfully installed jsonschema functools32 02:47:08 INFO - Cleaning up... 02:47:08 INFO - Return code: 0 02:47:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:47: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:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47: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:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47: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', '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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:47: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 functools32==3.2.3-2 02:47:08 INFO - Using env: {'DISPLAY': ':0', 02:47:08 INFO - 'HOME': '/home/cltbld', 02:47:08 INFO - 'LANG': 'en_US.UTF-8', 02:47:08 INFO - 'LANGUAGE': 'en_US:en', 02:47:08 INFO - 'LOGNAME': 'cltbld', 02:47:08 INFO - 'MAIL': '/var/mail/cltbld', 02:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:08 INFO - 'MOZ_NO_REMOTE': '1', 02:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:08 INFO - 'NO_EM_RESTART': '1', 02:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:08 INFO - 'PWD': '/builds/slave/test', 02:47:08 INFO - 'SHELL': '/bin/bash', 02:47:08 INFO - 'SHLVL': '1', 02:47:08 INFO - 'TERM': 'linux', 02:47:08 INFO - 'TMOUT': '86400', 02:47:08 INFO - 'USER': 'cltbld', 02:47:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:08 INFO - '_': '/tools/buildbot/bin/python'} 02:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:47:08 INFO - Cleaning up... 02:47:08 INFO - Return code: 0 02:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:47: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:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47: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:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47: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', '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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:47: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 blobuploader==1.2.4 02:47:08 INFO - Using env: {'DISPLAY': ':0', 02:47:08 INFO - 'HOME': '/home/cltbld', 02:47:08 INFO - 'LANG': 'en_US.UTF-8', 02:47:08 INFO - 'LANGUAGE': 'en_US:en', 02:47:08 INFO - 'LOGNAME': 'cltbld', 02:47:08 INFO - 'MAIL': '/var/mail/cltbld', 02:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:08 INFO - 'MOZ_NO_REMOTE': '1', 02:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:08 INFO - 'NO_EM_RESTART': '1', 02:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:08 INFO - 'PWD': '/builds/slave/test', 02:47:08 INFO - 'SHELL': '/bin/bash', 02:47:08 INFO - 'SHLVL': '1', 02:47:08 INFO - 'TERM': 'linux', 02:47:08 INFO - 'TMOUT': '86400', 02:47:08 INFO - 'USER': 'cltbld', 02:47:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:08 INFO - '_': '/tools/buildbot/bin/python'} 02:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:47: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:47: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:47: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:47: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:47:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:47:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:47: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:47: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:47: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:47: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:47:10 INFO - Downloading docopt-0.6.1.tar.gz 02:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:47:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:47:10 INFO - Running setup.py install for blobuploader 02:47:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:47:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:47:10 INFO - Running setup.py install for requests 02:47:10 INFO - Running setup.py install for docopt 02:47:10 INFO - Successfully installed blobuploader requests docopt 02:47:10 INFO - Cleaning up... 02:47:11 INFO - Return code: 0 02:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:11 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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:11 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:47:11 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:47:11 INFO - Using env: {'DISPLAY': ':0', 02:47:11 INFO - 'HOME': '/home/cltbld', 02:47:11 INFO - 'LANG': 'en_US.UTF-8', 02:47:11 INFO - 'LANGUAGE': 'en_US:en', 02:47:11 INFO - 'LOGNAME': 'cltbld', 02:47:11 INFO - 'MAIL': '/var/mail/cltbld', 02:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:11 INFO - 'MOZ_NO_REMOTE': '1', 02:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:11 INFO - 'NO_EM_RESTART': '1', 02:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:11 INFO - 'PWD': '/builds/slave/test', 02:47:11 INFO - 'SHELL': '/bin/bash', 02:47:11 INFO - 'SHLVL': '1', 02:47:11 INFO - 'TERM': 'linux', 02:47:11 INFO - 'TMOUT': '86400', 02:47:11 INFO - 'USER': 'cltbld', 02:47:11 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:11 INFO - '_': '/tools/buildbot/bin/python'} 02:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:11 INFO - Running setup.py (path:/tmp/pip-3Idmin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:11 INFO - Running setup.py (path:/tmp/pip-9lqCmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:11 INFO - Running setup.py (path:/tmp/pip-QLBQ3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:11 INFO - Running setup.py (path:/tmp/pip-f1hoc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:11 INFO - Running setup.py (path:/tmp/pip-lPBQbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:11 INFO - Running setup.py (path:/tmp/pip-EKxZpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:11 INFO - Running setup.py (path:/tmp/pip-K1cMot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:11 INFO - Running setup.py (path:/tmp/pip-MB4cqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:11 INFO - Running setup.py (path:/tmp/pip-xESO82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:11 INFO - Running setup.py (path:/tmp/pip-tl0hyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:11 INFO - Running setup.py (path:/tmp/pip-e1mXzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:12 INFO - Running setup.py (path:/tmp/pip-8ZvAju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:12 INFO - Running setup.py (path:/tmp/pip-VVNvGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:12 INFO - Running setup.py (path:/tmp/pip-kBCBiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:12 INFO - Running setup.py (path:/tmp/pip-z42cL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:12 INFO - Running setup.py (path:/tmp/pip-UzX7qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:12 INFO - Running setup.py (path:/tmp/pip-UYp01N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:47:12 INFO - Running setup.py install for manifestparser 02:47:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:47:12 INFO - Running setup.py install for mozcrash 02:47:12 INFO - Running setup.py install for mozdebug 02:47:12 INFO - Running setup.py install for mozdevice 02:47:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:47:12 INFO - Running setup.py install for mozfile 02:47:12 INFO - Running setup.py install for mozhttpd 02:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozinfo 02:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozInstall 02:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozleak 02:47:13 INFO - Running setup.py install for mozlog 02:47:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for moznetwork 02:47:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozprocess 02:47:13 INFO - Running setup.py install for mozprofile 02:47:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozrunner 02:47:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:47:13 INFO - Running setup.py install for mozscreenshot 02:47:13 INFO - Running setup.py install for moztest 02:47:14 INFO - Running setup.py install for mozversion 02:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:47:14 INFO - Cleaning up... 02:47:14 INFO - Return code: 0 02:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:14 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:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:14 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:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:14 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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:14 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:47:14 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:47:14 INFO - Using env: {'DISPLAY': ':0', 02:47:14 INFO - 'HOME': '/home/cltbld', 02:47:14 INFO - 'LANG': 'en_US.UTF-8', 02:47:14 INFO - 'LANGUAGE': 'en_US:en', 02:47:14 INFO - 'LOGNAME': 'cltbld', 02:47:14 INFO - 'MAIL': '/var/mail/cltbld', 02:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:14 INFO - 'MOZ_NO_REMOTE': '1', 02:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:14 INFO - 'NO_EM_RESTART': '1', 02:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:14 INFO - 'PWD': '/builds/slave/test', 02:47:14 INFO - 'SHELL': '/bin/bash', 02:47:14 INFO - 'SHLVL': '1', 02:47:14 INFO - 'TERM': 'linux', 02:47:14 INFO - 'TMOUT': '86400', 02:47:14 INFO - 'USER': 'cltbld', 02:47:14 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:14 INFO - '_': '/tools/buildbot/bin/python'} 02:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:14 INFO - Running setup.py (path:/tmp/pip-1Hyz1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:14 INFO - Running setup.py (path:/tmp/pip-9CpXgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:14 INFO - Running setup.py (path:/tmp/pip-ybPC82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:14 INFO - Running setup.py (path:/tmp/pip-5L9L7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:14 INFO - Running setup.py (path:/tmp/pip-KfSfZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:14 INFO - Running setup.py (path:/tmp/pip-cRQt8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:14 INFO - Running setup.py (path:/tmp/pip-99PFXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:14 INFO - Running setup.py (path:/tmp/pip-v4ER5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:14 INFO - Running setup.py (path:/tmp/pip-140bv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:15 INFO - Running setup.py (path:/tmp/pip-mdnfOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:15 INFO - Running setup.py (path:/tmp/pip-PkYGWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:15 INFO - Running setup.py (path:/tmp/pip-e7vLXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:15 INFO - Running setup.py (path:/tmp/pip-EDzXJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:15 INFO - Running setup.py (path:/tmp/pip-7RaVar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:15 INFO - Running setup.py (path:/tmp/pip-BZge8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:15 INFO - Running setup.py (path:/tmp/pip-NKH4OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:15 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:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:15 INFO - Running setup.py (path:/tmp/pip-nPtGwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:15 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:47:15 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:47:15 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:47:15 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:47:15 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:47:15 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:47:15 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:47:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:47: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:47: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:47: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:47: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:47:16 INFO - Downloading blessings-1.6.tar.gz 02:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:16 INFO - Installing collected packages: blessings 02:47:16 INFO - Running setup.py install for blessings 02:47:16 INFO - Successfully installed blessings 02:47:16 INFO - Cleaning up... 02:47:16 INFO - Return code: 0 02:47:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:17 INFO - Reading from file tmpfile_stdout 02:47:17 INFO - Current package versions: 02:47:17 INFO - argparse == 1.2.1 02:47:17 INFO - blessings == 1.6 02:47:17 INFO - blobuploader == 1.2.4 02:47:17 INFO - docopt == 0.6.1 02:47:17 INFO - functools32 == 3.2.3-2 02:47:17 INFO - jsonschema == 2.5.1 02:47:17 INFO - manifestparser == 1.1 02:47:17 INFO - mozInstall == 1.13 02:47:17 INFO - mozcrash == 1.0 02:47:17 INFO - mozdebug == 0.1 02:47:17 INFO - mozdevice == 0.51 02:47:17 INFO - mozfile == 1.2 02:47:17 INFO - mozhttpd == 0.7 02:47:17 INFO - mozinfo == 0.10 02:47:17 INFO - mozleak == 0.1 02:47:17 INFO - mozlog == 3.5 02:47:17 INFO - moznetwork == 0.27 02:47:17 INFO - mozprocess == 0.25 02:47:17 INFO - mozprofile == 0.28 02:47:17 INFO - mozrunner == 6.13 02:47:17 INFO - mozscreenshot == 0.1 02:47:17 INFO - mozsystemmonitor == 0.3 02:47:17 INFO - moztest == 0.8 02:47:17 INFO - mozversion == 1.4 02:47:17 INFO - psutil == 3.1.1 02:47:17 INFO - requests == 1.2.3 02:47:17 INFO - wsgiref == 0.1.2 02:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:17 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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:17 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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:17 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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 02:47:17 INFO - 'HOME': '/home/cltbld', 02:47:17 INFO - 'LANG': 'en_US.UTF-8', 02:47:17 INFO - 'LANGUAGE': 'en_US:en', 02:47:17 INFO - 'LOGNAME': 'cltbld', 02:47:17 INFO - 'MAIL': '/var/mail/cltbld', 02:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:17 INFO - 'MOZ_NO_REMOTE': '1', 02:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:17 INFO - 'NO_EM_RESTART': '1', 02:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:17 INFO - 'PWD': '/builds/slave/test', 02:47:17 INFO - 'SHELL': '/bin/bash', 02:47:17 INFO - 'SHLVL': '1', 02:47:17 INFO - 'TERM': 'linux', 02:47:17 INFO - 'TMOUT': '86400', 02:47:17 INFO - 'USER': 'cltbld', 02:47:17 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:17 INFO - '_': '/tools/buildbot/bin/python'} 02:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:47:17 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:47:17 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:47:17 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:47:17 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:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:47:18 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:47:18 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:47:18 INFO - Installing collected packages: simplejson 02:47:18 INFO - Running setup.py install for simplejson 02:47:18 INFO - building 'simplejson._speedups' extension 02:47:18 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:47:19 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:47:19 INFO - Successfully installed simplejson 02:47:19 INFO - Cleaning up... 02:47:19 INFO - Return code: 0 02:47:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:47:19 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:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:19 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:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:19 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 0x223d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2406a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, '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': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', '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:47:19 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:47:19 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:47:19 INFO - Using env: {'DISPLAY': ':0', 02:47:19 INFO - 'HOME': '/home/cltbld', 02:47:19 INFO - 'LANG': 'en_US.UTF-8', 02:47:19 INFO - 'LANGUAGE': 'en_US:en', 02:47:19 INFO - 'LOGNAME': 'cltbld', 02:47:19 INFO - 'MAIL': '/var/mail/cltbld', 02:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:19 INFO - 'MOZ_NO_REMOTE': '1', 02:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:19 INFO - 'NO_EM_RESTART': '1', 02:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:19 INFO - 'PWD': '/builds/slave/test', 02:47:19 INFO - 'SHELL': '/bin/bash', 02:47:19 INFO - 'SHLVL': '1', 02:47:19 INFO - 'TERM': 'linux', 02:47:19 INFO - 'TMOUT': '86400', 02:47:19 INFO - 'USER': 'cltbld', 02:47:19 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:19 INFO - '_': '/tools/buildbot/bin/python'} 02:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:47:19 INFO - Cleaning up... 02:47:19 INFO - Return code: 0 02:47:19 INFO - Running post-action listener: _resource_record_post_action 02:47:19 INFO - Running post-action listener: _start_resource_monitoring 02:47:19 INFO - Starting resource monitoring. 02:47:19 INFO - [mozharness: 2017-09-16 09:47:19.915724Z] Finished create-virtualenv step (success) 02:47:19 INFO - [mozharness: 2017-09-16 09:47:19.916200Z] Running install step. 02:47:19 INFO - Running pre-action listener: _resource_record_pre_action 02:47:19 INFO - Running main action method: install 02:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:20 INFO - Reading from file tmpfile_stdout 02:47:20 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:47:20 INFO - Reading from file tmpfile_stdout 02:47:20 INFO - Output received: 02:47:20 INFO - Usage: mozinstall [options] installer 02:47:20 INFO - Options: 02:47:20 INFO - -h, --help show this help message and exit 02:47:20 INFO - -d DEST, --destination=DEST 02:47:20 INFO - Directory to install application into. [default: 02:47:20 INFO - "/builds/slave/test"] 02:47:20 INFO - --app=APP Application being installed. [default: firefox] 02:47:20 INFO - mkdir: /builds/slave/test/build/application 02:47:20 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:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:47:38 INFO - Reading from file tmpfile_stdout 02:47:38 INFO - Output received: 02:47:38 INFO - /builds/slave/test/build/application/firefox/firefox 02:47:38 INFO - Running post-action listener: _resource_record_post_action 02:47:38 INFO - [mozharness: 2017-09-16 09:47:38.019528Z] Finished install step (success) 02:47:38 INFO - [mozharness: 2017-09-16 09:47:38.019780Z] Running setup-mitmproxy step. 02:47:38 INFO - Running pre-action listener: _resource_record_pre_action 02:47:38 INFO - Running main action method: setup_mitmproxy 02:47:38 INFO - Skipping: mitmproxy is not required 02:47:38 INFO - Running post-action listener: _resource_record_post_action 02:47:38 INFO - [mozharness: 2017-09-16 09:47:38.020906Z] Finished setup-mitmproxy step (success) 02:47:38 INFO - [mozharness: 2017-09-16 09:47:38.021127Z] Running run-tests step. 02:47:38 INFO - Running pre-action listener: _resource_record_pre_action 02:47:38 INFO - Running pre-action listener: _set_gcov_prefix 02:47:38 INFO - Running main action method: run_tests 02:47:38 WARNING - Try message not found. 02:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:38 INFO - Python 2.7.3 02:47:38 INFO - Return code: 0 02:47:38 INFO - grabbing minidump binary from tooltool 02:47:38 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:47:38 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 0x25ad090>, '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 0x25add80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a7f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:38 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:47:38 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:47:38 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:47:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:38 INFO - Return code: 0 02:47:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:47:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:38 INFO - ENV: RUST_BACKTRACE is now full 02:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:38 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/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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:47:38 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/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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:47:38 INFO - Using env: {'DISPLAY': ':0', 02:47:38 INFO - 'HOME': '/home/cltbld', 02:47:38 INFO - 'LANG': 'en_US.UTF-8', 02:47:38 INFO - 'LANGUAGE': 'en_US:en', 02:47:38 INFO - 'LOGNAME': 'cltbld', 02:47:38 INFO - 'MAIL': '/var/mail/cltbld', 02:47:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:47:38 INFO - 'MOZ_ACCELERATED': '1', 02:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:38 INFO - 'MOZ_NO_REMOTE': '1', 02:47:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:38 INFO - 'MOZ_WEBRENDER': '1', 02:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:38 INFO - 'NO_EM_RESTART': '1', 02:47:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:38 INFO - 'PWD': '/builds/slave/test', 02:47:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:38 INFO - 'RUST_BACKTRACE': 'full', 02:47:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:47:38 INFO - 'SHELL': '/bin/bash', 02:47:38 INFO - 'SHLVL': '1', 02:47:38 INFO - 'TERM': 'linux', 02:47:38 INFO - 'TMOUT': '86400', 02:47:38 INFO - 'USER': 'cltbld', 02:47:38 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:38 INFO - '_': '/tools/buildbot/bin/python'} 02:47:38 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/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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:47:38 INFO - mozversion application_buildid: 20170916085847 02:47:38 INFO - mozversion application_changeset: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 02:47:38 INFO - mozversion application_display_name: Nightly 02:47:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:38 INFO - mozversion application_name: Firefox 02:47:38 INFO - mozversion application_remotingname: firefox 02:47:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:47:38 INFO - mozversion application_vendor: Mozilla 02:47:38 INFO - mozversion application_version: 57.0a1 02:47:38 INFO - mozversion platform_buildid: 20170916085847 02:47:38 INFO - mozversion platform_changeset: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 02:47:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:47:38 INFO - mozversion platform_version: 57.0a1 02:47:38 INFO - using testdate: 1505555258 02:47:38 INFO - actual date: 1505555258 02:47:38 INFO - starting webserver on 'localhost:40306' 02:47:38 INFO - SUITE-START | Running 2 tests 02:47:38 INFO - TEST-START | dromaeo_css 02:47:38 INFO - Initialising browser for dromaeo_css test... 02:47:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40306/getInfo.html -profile /tmp/tmptI7pah/profile 02:47:38 INFO - TEST-INFO | started process 17727 (/builds/slave/test/build/application/firefox/firefox http://localhost:40306/getInfo.html) 02:47:44 INFO - TEST-INFO | 17727: exit 0 02:47:44 INFO - Browser initialized. 02:47:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:44 INFO - Using env: {'DISPLAY': ':0', 02:47:44 INFO - 'HOME': '/home/cltbld', 02:47:44 INFO - 'JSGC_DISABLE_POISONING': '1', 02:47:44 INFO - 'LANG': 'en_US.UTF-8', 02:47:44 INFO - 'LANGUAGE': 'en_US:en', 02:47:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:47:44 INFO - 'LOGNAME': 'cltbld', 02:47:44 INFO - 'MAIL': '/var/mail/cltbld', 02:47:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:47:44 INFO - 'MOZ_ACCELERATED': '1', 02:47:44 INFO - 'MOZ_CRASHREPORTER': '1', 02:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:47:44 INFO - 'MOZ_NO_REMOTE': '1', 02:47:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:44 INFO - 'MOZ_WEBRENDER': '1', 02:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:44 INFO - 'NO_EM_RESTART': '1', 02:47:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:44 INFO - 'PWD': '/builds/slave/test', 02:47:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:44 INFO - 'RUST_BACKTRACE': 'full', 02:47:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:47:44 INFO - 'SHELL': '/bin/bash', 02:47:44 INFO - 'SHLVL': '1', 02:47:44 INFO - 'TERM': 'linux', 02:47:44 INFO - 'TMOUT': '86400', 02:47:44 INFO - 'USER': 'cltbld', 02:47:44 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 02:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:44 INFO - '_': '/tools/buildbot/bin/python'} 02:47:44 INFO - TEST-INFO | started process 17975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptI7pah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:45 INFO - PID 17975 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:47:45 INFO - PID 17975 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:47:45 INFO - PID 17975 | 02:47:45 INFO - PID 17975 | (/builds/slave/test/build/application/firefox/firefox:18034): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:47:45 INFO - PID 17975 | 02:47:56 INFO - PID 17975 | RSS: Main: 194523136 02:47:56 INFO - PID 17975 | 02:50:53 INFO - PID 17975 | Cycle 1(1): loaded http://localhost:40306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40306/tests/dromaeo/cssquery-ext.html) 02:50:55 INFO - PID 17975 | RSS: Main: 207691776 02:50:55 INFO - PID 17975 | 02:53:57 INFO - PID 17975 | Cycle 1(1): loaded http://localhost:40306/tests/dromaeo/cssquery-ext.html (next: http://localhost:40306/tests/dromaeo/cssquery-jquery.html) 02:53:58 INFO - PID 17975 | RSS: Main: 205225984 02:53:58 INFO - PID 17975 | 02:57:00 INFO - PID 17975 | Cycle 1(1): loaded http://localhost:40306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40306/tests/dromaeo/cssquery-mootools.html) 02:57:00 INFO - PID 17975 | RSS: Main: 207380480 02:57:00 INFO - PID 17975 | 03:00:02 INFO - PID 17975 | Cycle 1(1): loaded http://localhost:40306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40306/tests/dromaeo/cssquery-prototype.html) 03:00:03 INFO - PID 17975 | RSS: Main: 205389824 03:00:03 INFO - PID 17975 | 03:03:07 INFO - PID 17975 | Cycle 1(1): loaded http://localhost:40306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40306/tests/dromaeo/cssquery-yui.html) 03:03:07 INFO - PID 17975 | RSS: Main: 206798848 03:03:07 INFO - PID 17975 | 03:06:09 INFO - PID 17975 | Cycle 1(1): loaded http://localhost:40306/tests/dromaeo/cssquery-yui.html (next: http://localhost:40306/tests/dromaeo/cssquery-dojo.html) 03:06:10 INFO - PID 17975 | RSS: Main: 212602880 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | __start_tp_report 03:06:10 INFO - PID 17975 | _x_x_mozilla_page_load 03:06:10 INFO - PID 17975 | _x_x_mozilla_page_load_details 03:06:10 INFO - PID 17975 | |i|pagename|runs| 03:06:10 INFO - PID 17975 | |0;dojo.html;3067.29452225988;3098.4422803895295;3101.333213359129;3115.5949726535546;3121.422536830685;6092.390760923905;6178.413050760176;6195.442410183083;6249.062640603912;6348.587341822778;6180.381961803817;6233.844153896155;6334.746610135589;6387.361263873622;6408.519361047916;5651.7739290428335;5724;5757.337906140785;5817.476427121558;5839.211706419643;5717.571182161334;5783.392743761908;5871.559633027518;5888.057910734284;5890.88218235635;5657.264555607786;5708.571857110713;5729.885402291972;5748.511376533;5859.44335288147;5578.079616863253;5633.0987042073075;5721.513671337942;5759;5799.82600521985;5674.546036317085;5745.2243947067445;5751.568632352591;5755.251817263771;5757;6232.844178895519;6257.124002639634;6320.905186422207;6341.2707538633185;6365.968170159166;6536.509761767887;6622.801315960481;6632.900506492407;6695.631740254284;6781.050652908597;6696.665166741644;6737.292584278629;6770.492213084039;6781.593104413751;6808.2170550386345;6022.879542409128;6268.968655156695;6281.277653069909;6286.591371560834;6303.747850086037;6793.218779840382;6886.345797149263;6897.206821215625;6998.055262539492;7042.753503627451;6584.86830263392;6649.767258145942;6652.135222421151;6695.263521012685;6733.8653226935185;6654.168228971379;6739.056532085512;6759.493038022168;6826.180858297036;6840.863182736317;6436.967815160894;6615.239247486601;6664.067030615718;6745.291744366869;6800.455963522906;6743.055972163901;6748.527603067738;6765.695543700545;6768.56004359715;6776.356246156607;5266.1574148136115;5269.604779641542;5278.868028299324;5279.102552566073;5322.680639161663;4561.612262957619;4616.007558374966;4631.3516107744945;4657.347971284023;4678.906421871611;5640.379558248589;5770.596058275881;5770.913436298459;5816;5818.709064546756;6663.500237482208;6708.899366509506;6792.354726300993;6808.421284190899;6819.795406137824;5735;5757.913631295534;5796.391378905154;5806.361300256968;5839.445252701072;5792.131180322901;5829.679367634736;5867.413258674183;5868.09044598088;5879.235699359056;6485.1245081914285;6486.254080780676;6509.121268628769;6577.967110164419;6590.340965903371;6588.868222635425;6676.265610782907;6741.898871516931;6754.831129221612;6836.28219036994;6439.903401449075;6468.676566171766;6521.217453905561;6570.211574611078;6577.934220657732;6668.83327916806;6735.057092007025;6739.629320387229;6741.258461569321;6767.289434609492;6780.593164410151;6791.694373753094;6801.761938332134;6888.7244510221035;6889.552179108342;6379.043143528323;6568.573042752206;6570.967145164243;6617.2721000688925;6668.933310666831;6360.173177486897;6408.679566021587;6580.1116849226655;6597.967010164918;6598.8350291243105;6463.15978922737;6482.157319548429;6539.019147127969;6542.869142617216;6582;6569.310222426577;6612.603243805387;6615.272320044695;6659.600423974577;6669.633170175687;6221.782237621843;6362.872742545031;6390.748931333585;6467.676616169078;6481.837954051187 03:06:10 INFO - PID 17975 | |1;ext.html;845.3575282785083;859.4070091636775;885.982280354393;887.3344991256556;889.3196704521039;38821.80589097054;42539.14921701568;42581;42715;42829.35755963663;38725.61274387255;39309.80345098278;39313.213735725265;39315.80342098293;39374.21251574967;6962.721491140348;7120.465965052642;7121.715131394738;7121.928780712205;7124.5725256484775;7022.648867556627;7099.645017749118;7103.644817759117;7108.573485590881;7112.85774284514;7080.964595177017;7093.822654433655;7097.645117744118;7107.644617769117;7112.075430194068;7624.313811756941;7815.882761758578;7824.21757824213;7852.842943141134;7859.292663660298;7660.080790305144;7672.884906726348;7757.9224207758325;7806.72676456327;7831.8433631327625;37289.440658390144;37895.621043789484;37897.62102378969;37902.62097379019;38949;3578.9284214315567;3597.8560857565926;3613.403788374915;3615.2227271136567;3622.2755448910325;32733.18167045819;32819;32867.34265314704;33092.503612445835;33108.17229569256;5228.372595288552;5230.92153617696;5248.580113590941;5278.762455689503;5288.286081379003;185984;187855;187932.06033969743;188274;189561.99999999863;43382.34926476042;43794.343084853754;49174.754126229855;49654.751726241135;49904.251436228486;45504.317435238496;45657.54342456599;52471.73764131231;52643;52695;15693.215339232993;15785;15820.367185312689;15919.681606367807;15966.121863297398;12710.364481775874;12773.425195866208;12830.422630981628;12845.550405735754;12855.292958887165;14332.283385830875;14372.281385930663;14394.712105757826;14456.494022709154;14493.275336233146;5749.310082790092;5848.502877255481;5851.707414629252;5963.344032156459;5979.133025711248;1010.3483253301579;1014.2038499777639;1028.141501845967;1030.299396410433;1037.823569993103;23076;23629.527409452057;23794.64308035381;23820.52358952811;23921.043158273475;1086.163653986426;1099.9450027498592;1110.5169251375678;1123.921325507223;1136.267107715519;12336.198147120409;12483.126181167412;12504;12670.429830657642;12715.809262861065;219840;220079;220291;221079;221830;53261.467385326425;53399.46600533945;53532.73233633885;53636.73181634067;54096.18855717168;1382.585224432666;1445.5374280230226;1459.9708005839823;1463.9048461849945;1477.1284941884126;22936;23082.538349232585;23137.652935206323;23238.125658160665;23819.761802382447;37220.06949826276;37537.81231093827;37593.62406376011;37644.81177594094;37668.62331376651;143091.28454357662;143116;143370;143611;143744;32988;35548.28903421865;35617.64382356143;35911;35976.64023359837;43179.35230971475;43438.13123737571;43868.78065609652;44312;44740.55259447494;31990.84004579962;32245;32318.83840580782;32543.837280813445;32678;31060;31380.37239255248;31490.685093148775;31541.21146971252;31938.36123277475;35474.290514190085;35599;35858.4621230687;35942.640573593926;35961;30757.692423076376;30769.846150769103;30807.075787726404;30990.845045774626;31284.37431251408;23228.070877164722;23575;23605.763942360358;23681;23696.52606947886 03:06:10 INFO - PID 17975 | |2;jquery.html;568.210187838904;572.530524969525;573.5268403567055;574.7241324164398;586.6069733278703;22544.54910901781;23368.298951031455;23403;23418.648720269168;23451.882740586316;23409;24290.271291861274;24518.877405612948;24701.270911036234;24747.50504989899;6516.087747715312;6576.0793488911595;6580.5722628029025;6586.27550969393;6591.209054913417;6448.419642232222;6473.6763161841955;6479.838004049913;6532.934670653304;6542.1495205623205;6312.968435157841;6593.20881494219;6618.238902526223;6619.536632435707;6628.834279143036;6526.673666316665;6554.5739526931075;6558.967205163967;6614.305497922721;6651.667416629173;5816.127580862904;6047.213862197887;6057.969710151465;6094.481969032638;6146.907796383058;28227.57658635122;28680;28687.85656071727;28733.425331493254;28743.85628071846;2036.8370530357536;2060.1553363121197;2061.0313152818153;2061.845361597886;2062.1957436599587;17982.460526184237;18596.256149753994;18762;18858.62282754351;18877.528061798428;2389.3548741839604;2447.7674620910984;2451.350392146083;2455.4966231922413;2469.4814089041324;119139.4043029788;124064.37967810193;125350;136346;142039.28980355136;13979;14061.367238474293;14388.352524136439;14461.638459038399;14480.637984050483;22419.887900560392;22527.88736056342;22560.66159007616;22575.774242257696;22665.093396264296;9302.86045709315;9566.426014439156;9632.133108020313;9769.90230097704;9952.850707239397;9140.817183656289;9157.862632060524;9169.679061232824;9203.677871274473;9263.16631503168;8765.780855478537;8777.122287771172;8837.867431988525;8925.36701673008;8955.104489551122;2543.2649375657775;2629.6581444412104;2656.455426637535;2661.4450127877453;2701.986490067537;959.3859929645033;960.8277900960817;967.086103632075;973.9659111931048;986.5560497775886;18549.90725046366;18666.906665466584;19043.90478047601;19145.234190632218;19209.135588898534;1024.6248518824577;1027.768752030787;1029.7271223125729;1039.656913218636;1042.3745752548562;10250.692479225636;10464.21518386124;10592.099671528007;10620.256582039183;10627.09669678086;457819;467556;469938;472658;484909;108963.45518272358;109061;109623;110875.44562277137;111780;1149.2816989381636;1155.5262342439728;1235.43170141734;1237.9442925068213;1248.7502499499954;19634.410967670992;19689.21243150258;19960.60078798445;20199.39401817948;20257.797422025593;52967;55639.72180139073;56041.15938261011;56264;56557;66851;68194;69665;70000;70806.64596676984;13980.370883310072;14006.859931400555;14131.64670883236;14207.147571145764;14376.784348234576;22062.669059964435;22244.221452249094;22409.77590224077;22550.887245563667;22628.886855566274;17685.55786105306;17686.380976665754;17748.201330940396;17983.910080449514;18007.369742058963;15622.375104995674;16045.19774011318;16424.09667468253;16514.25685844116;16777.161141942608;18536;18549.258029678662;18642.81357186465;18703.1583578742;18772.812271877654;12957.805632915326;13983.580492585239;13989.860101398855;14033;14082.507112251022;17426;17716.11419429049;17720.734188987433;17783.911080444515;17933 03:06:10 INFO - PID 17975 | |3;mootools.html;1277.36131934033;1370.506617617657;1371.801088842118;1385.9376328065243;1390.1103293891908;14994.40022399104;15609.921950390231;15637.061776293416;15645.452409165682;15657.608559786011;15232.771508427382;15461.92269038656;15480.225988700577;15535.844641553582;15611.375544978187;2703.716109808466;2815.8873645054277;2819.407924335892;2820.2244382794693;2821.7883658725573;2730.9044183453584;2743.8353698778037;2754.2425832895915;2775.2368098772795;2775.5559110542317;2681.6647919010124;2710.159850446358;2755.118362124121;2756.4349308391834;2757.2279761666764;2565.3586603349163;2633.4074833162576;2641.075623531758;2642.4979253941688;2644.2331723800266;2634.6048092786045;2651.814372993891;2652.0585192256663;2658.8404695718127;2664.5203863304596;14748.926255368655;14761.33573989173;14787.482438114614;14918.850811491855;14990.775138372825;7908;8222.712205072854;8236.094029656733;8274.751757447286;8275.875861862016;5355.250264962909;5497.47773961473;5622.57830662702;5651.378348381675;5692.0608099663505;1868.4955062133147;1877.483691984715;1882.3223639489772;1900.7624046994126;1943.0867492278749;23783.643245351333;25089.24732258035;26011.869940650366;27212.59181112285;27251.182464526097;7250.9637451812405;7291.270872912773;7366.521176123535;7431.888521672179;7485.438592105614;20186.899065504578;20217.696734548994;20258.885761283273;20270.594588108157;20296.695549566768;8398.916010839814;8506.191911768372;8506.74479765608;8519.531425771642;8521.488710677379;6909.689063992132;7328.963355183297;7345.55926644403;7397.667104980289;7591.62041897914;5491.65454463651;5704.1443783432815;5718.056520674126;5734.827955161269;5746.626469279484;1746.336392170967;1772.2556526259002;1793.3006127610242;1813.86396020299;1827.4060930197472;880.097899652861;893.2273583350355;911.3210658059788;916.2852974679761;925.5418567808844;7370.226126256773;7395.4083673306;7417.10994680631;7422.620653814275;7448.553086814808;707.9575225486487;708.0370695853635;712.9251428599922;714.9356557909813;722.8301349182938;4518.593326600621;4599.862004139881;4610.262358022767;4613.492515823256;4618.815247390134;21055.8947205263;21598.460038499165;22041.338759837232;22146.667799983014;22250.443738906655;21140.365789026353;21413.357599272047;21730;21772.782272177392;21832.78167218339;10173;10351.792964140675;10386.584536618602;10480.056794888344;10530.21023423231;8473.5339556325;8533.146685331665;8596.35527335465;8622.698205562776;8670.739877803677;18602.906985464986;18871;18921.90539047296;19241.230350785812;19431.902840485705;19012.049397530343;19019.524511887314;19587.412377628694;19609.11758970821;20096.095675694338;11735.41322933867;11891.643250702493;11953.940230298793;11990.160688751703;12002.819957700467;13527.256000920044;13771.724565508433;13922.930385348009;14010.369533371226;14025.579232623038;11371.090312774793;11894.464749086485;11923.642290731292;11935.582254621047;11953.521859125538;11323.716907077389;11406.201565890307;11456.484458199568;11488.310701357945;11598.07215422781;9621.951890240503;9760.219182465527;9824.06671366219;9893.703188904345;9896.554655040685;7505.949167116717;7572.432067594842;7691.038620172479;7697.769066928001;7855.37157027425;7717.151113377637;7760.611969401621;7772.805679858049;7816.335611473089;7826.139124696165 03:06:10 INFO - PID 17975 | |4;prototype.html;492.3107649290992;503.29287351271455;523.3941316415544;527.588480984832;537.0655060195259;6010.819675409739;6193.163922870411;6224.128621992924;6234.812955611339;6259;6143.846403839906;6183.907241391383;6183.938160618392;6189.876202475959;6191.678120704736;5187.976689091258;5214.791408343662;5216.843494695147;5217.556507696831;5242.501962313593;4867.707937523742;5008.724520151391;5043.470435604264;5048.242763585473;5122.564582010534;5014.24786282057;5019.723915184663;5022.748862556876;5033.823816166435;5037.697738135706;4868.123737727207;4995.950040499585;4996.650234483587;5010.148274793276;5026.949730502684;4392.692511524195;4449.688521803475;4453.37652728615;4459.197344477992;4497.617702495292;6025.307089684698;6087.817365479043;6113.847153821145;6147.170132032164;6161.476274516672;5686.744096515626;5714.914276285859;5762.818622182443;5777.566682498829;5792.623479473821;6503.707333169971;6520.43569501351;6565.638889861056;6629.204495460527;6645.235797883257;4753.904921901577;4827.637927155477;4855.708657480527;4856.3201151838775;4861.83980412731;6803.319668033207;6906.309369063053;6918.792436226921;6925.515213935027;6975;4954.801807927643;5062.670926389773;5075.2387141929;5075.593952483792;5102.132637451642;5055.51972562606;5057.848264552069;5066.746662666926;5081.8475445736685;5145.536901678867;5615.803446879421;5649.548036157097;5661.348944871393;5688.914666280009;5743.0811070228565;6534.705938232791;6602.3067577904585;6663.933360666429;6678;6680.732770689216;1633.4364644197733;1679.9748003779953;1684.6967545841621;1692.7122389193867;1746.0658547676933;1188.304841667634;1211.939403029845;1245.6325384011739;1246.5450110709526;1248.6951136062837;5574.1917421973585;5604.299462567179;5713.285839270091;5731.140328950691;5753.311051493103;6492.67536623167;6499.707513161919;6501.284858665543;6506.640550830954;6589.705147426287;5531.502164805187;5682.1021279147935;5686.3744988051285;5728.885422291531;5733.483986441241;3481.9303613928087;3489.7557170998293;3509.6139424663265;3539.592946811098;3543.6987856032524;6115.480184184395;6338.936610633927;6344.58760180596;6360.777372792023;6408.231012278557;6827.761028364082;6828.5220034597105;6855.520113592101;6884.4148247399535;6890.655467226718;6272.153259309935;6298.905516417258;6372.58578192416;6412.2625898022325;6416.486681065504;6572.934270657232;6574.572652777745;6664.166979127609;6681.164854393201;6695.765648202484;6491.837704057436;6519.23980525246;6532.804015879531;6616.676664666989;6623.701933412912;6283.5287353449585;6335.176427064452;6340.904886426615;6346.048092785934;6382.5532212744665;4852.126617208936;4924.975375123101;4964.205727083649;4976.701397916137;4979.0788704089855;6661;6667.599944003181;6691.933080669131;6713.395794378529;6715.731370745116;6412.583182093149;6438.549301548846;6521;6536.182977127859;6544.312847150981;6394.968025159845;6434.453071488976;6547.476201903741;6558.672066396756;6608.909529927508;6132.62016046386;6236.937630623635;6318.8736225274315;6351.396617321347;6476.6114033158165;6138.6009909357535;6495.220573531206;6521.347865213441;6546.345365463416;6629.171353580802;6351.650659213788;6379.086274117839;6379.7129129190225;6402.295747467868;6445.807525607777 03:06:10 INFO - PID 17975 | |5;yui.html;911.9908800911991;933.4772527384661;940.8541676040212;947.1617618407712;950.9144177024067;19553.120109595067;20185.091670874826;20273.59452810943;20285.188592456285;20342.08460619272;18834.623307533842;19143.234270629157;19191.23235070599;19209.231630734754;19216.327428540004;936.6347124621403;946.3139224062551;950.353759443578;951.3720944176845;951.4243882451121;967.2165545907802;969.2488321550819;969.8351280282369;975.3172779054655;976.7851072763981;989.534918588266;1020.6784862768242;1043.6660268714015;1046.785408991155;1052.2318707343643;1036.160709825044;1037.4345981440094;1039.3763741754963;1039.9480025998746;1040.6461802986983;719.6257945868172;744.4342299852151;748.6294284329238;755.7543798265531;756.5309508104955;19046.61906761857;19434.416967490997;19533.609327813363;19636.80363196364;19724;21023.369298921058;21100.788992110036;21535.461613459633;21586.676199857015;21662.133514659396;17275.654486910193;17577;17601.94388336704;17639.294428222856;17712.645747084985;3802.049487628093;3816.751911125768;3826.770393776382;3831.616838316146;3833.750806197616;108051.61832030487;143791;149445.25277373652;149732;150527;16819.91590042042;17091.914540427468;17246.137693115295;17250.741238881426;17323.56691082733;31798.523022154684;32405.18987025296;32446.351072978407;32645.836770815993;32652.346953060805;8751.737447876574;9124.58939347731;9144.954275228582;9154.954225228965;9335.953320233355;4269.935950960738;4321.330193819963;4333.263345231255;4334.9783251083545;4341.717788343748;5499.257600223918;5586.776528938878;5590.105583106765;5641.266635337462;5672.574556908248;1078.6116997880756;1083.1605505732962;1099.769048499808;1101.3171833463305;1109.6005438042298;688.6178171114979;701.347746595671;708.4190963409955;711.647734371479;713.3900515059653;11956.58151964677;12849.293288869201;13054.673633159056;13209.669758255928;13535.661608459868;706.6925887239067;710.8791505444087;719.9676014579356;730.1603156370217;736.120336198238;5917.52659787216;5941.673207973517;5978.671173085435;6007.879842403127;6106.45041946227;118229.40885295518;120731;121806;122537;123989;86163.13836861552;100563;105473.47263263635;113055.43472282586;115417.99999999833;91287.99999999868;92337;93171.53414233022;94271.52864235635;95470.52264738631;12942.352882356034;13188.934055330046;13195.67010824737;13210;13338.866611333762;40104;41025.56410525617;41043.7947810271;42485.362719558616;43356.132877342905;54960.450395495536;55353.44646553483;55961.44038559725;56348;56521.15218271647;18344.541386464913;18477.16852741657;18489.81510184881;18529.44411667652;18991.33530326432;20004.799952000874;20775.168993240102;20789.584208316053;20938;21234.681479777508;17483.56291092733;18298.176582053573;18585.53536161607;18676.719849202;18688;17388.43537074922;17525.386611468537;17707.557311067325;17847.821521785136;17898.194581244137;17634.647307054045;17937;17993.640127197643;18037.368692095715;18193.81806181974;13347.599572012856;13475.3936072875;13480.93259533696;13581.932090339486;14077.718445630826;14095.154290742588;14217.786733199217;14264.714705706036;14324.212168330841;14389.568312950629 03:06:10 INFO - PID 17975 | __end_tp_report 03:06:10 INFO - PID 17975 | __start_cc_report 03:06:10 INFO - PID 17975 | _x_x_mozilla_cycle_collect,365 03:06:10 INFO - PID 17975 | __end_cc_report 03:06:10 INFO - PID 17975 | __startTimestamp1505556370034__endTimestamp 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | ------- Summary: start ------- 03:06:10 INFO - PID 17975 | Number of tests: 6 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | [#0] dojo.html Cycles:165 Average:6184.72 Median:6439.90 stddev:754.66 (11.7%) stddev-sans-first:716.25 03:06:10 INFO - PID 17975 | Values: 3067.3 3098.4 3101.3 3115.6 3121.4 6092.4 6178.4 6195.4 6249.1 6348.6 6180.4 6233.8 6334.7 6387.4 6408.5 5651.8 5724.0 5757.3 5817.5 5839.2 5717.6 5783.4 5871.6 5888.1 5890.9 5657.3 5708.6 5729.9 5748.5 5859.4 5578.1 5633.1 5721.5 5759.0 5799.8 5674.5 5745.2 5751.6 5755.3 5757.0 6232.8 6257.1 6320.9 6341.3 6366.0 6536.5 6622.8 6632.9 6695.6 6781.1 6696.7 6737.3 6770.5 6781.6 6808.2 6022.9 6269.0 6281.3 6286.6 6303.7 6793.2 6886.3 6897.2 6998.1 7042.8 6584.9 6649.8 6652.1 6695.3 6733.9 6654.2 6739.1 6759.5 6826.2 6840.9 6437.0 6615.2 6664.1 6745.3 6800.5 6743.1 6748.5 6765.7 6768.6 6776.4 5266.2 5269.6 5278.9 5279.1 5322.7 4561.6 4616.0 4631.4 4657.3 4678.9 5640.4 5770.6 5770.9 5816.0 5818.7 6663.5 6708.9 6792.4 6808.4 6819.8 5735.0 5757.9 5796.4 5806.4 5839.4 5792.1 5829.7 5867.4 5868.1 5879.2 6485.1 6486.3 6509.1 6578.0 6590.3 6588.9 6676.3 6741.9 6754.8 6836.3 6439.9 6468.7 6521.2 6570.2 6577.9 6668.8 6735.1 6739.6 6741.3 6767.3 6780.6 6791.7 6801.8 6888.7 6889.6 6379.0 6568.6 6571.0 6617.3 6668.9 6360.2 6408.7 6580.1 6598.0 6598.8 6463.2 6482.2 6539.0 6542.9 6582.0 6569.3 6612.6 6615.3 6659.6 6669.6 6221.8 6362.9 6390.7 6467.7 6481.8 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | [#1] ext.html Cycles:180 Average:35659.39 Median:19718.70 stddev:48390.70 (245.4%) stddev-sans-first:48455.84 03:06:10 INFO - PID 17975 | Values: 845.4 859.4 886.0 887.3 889.3 38821.8 42539.1 42581.0 42715.0 42829.4 38725.6 39309.8 39313.2 39315.8 39374.2 6962.7 7120.5 7121.7 7121.9 7124.6 7022.6 7099.6 7103.6 7108.6 7112.9 7081.0 7093.8 7097.6 7107.6 7112.1 7624.3 7815.9 7824.2 7852.8 7859.3 7660.1 7672.9 7757.9 7806.7 7831.8 37289.4 37895.6 37897.6 37902.6 38949.0 3578.9 3597.9 3613.4 3615.2 3622.3 32733.2 32819.0 32867.3 33092.5 33108.2 5228.4 5230.9 5248.6 5278.8 5288.3 185984.0 187855.0 187932.1 188274.0 189562.0 43382.3 43794.3 49174.8 49654.8 49904.3 45504.3 45657.5 52471.7 52643.0 52695.0 15693.2 15785.0 15820.4 15919.7 15966.1 12710.4 12773.4 12830.4 12845.6 12855.3 14332.3 14372.3 14394.7 14456.5 14493.3 5749.3 5848.5 5851.7 5963.3 5979.1 1010.3 1014.2 1028.1 1030.3 1037.8 23076.0 23629.5 23794.6 23820.5 23921.0 1086.2 1099.9 1110.5 1123.9 1136.3 12336.2 12483.1 12504.0 12670.4 12715.8 219840.0 220079.0 220291.0 221079.0 221830.0 53261.5 53399.5 53532.7 53636.7 54096.2 1382.6 1445.5 1460.0 1463.9 1477.1 22936.0 23082.5 23137.7 23238.1 23819.8 37220.1 37537.8 37593.6 37644.8 37668.6 143091.3 143116.0 143370.0 143611.0 143744.0 32988.0 35548.3 35617.6 35911.0 35976.6 43179.4 43438.1 43868.8 44312.0 44740.6 31990.8 32245.0 32318.8 32543.8 32678.0 31060.0 31380.4 31490.7 31541.2 31938.4 35474.3 35599.0 35858.5 35942.6 35961.0 30757.7 30769.8 30807.1 30990.8 31284.4 23228.1 23575.0 23605.8 23681.0 23696.5 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | [#2] jquery.html Cycles:180 Average:33534.77 Median:23016.70 stddev:79156.99 (343.9%) stddev-sans-first:79340.35 03:06:10 INFO - PID 17975 | Values: 568.2 572.5 573.5 574.7 586.6 22544.5 23368.3 23403.0 23418.6 23451.9 23409.0 24290.3 24518.9 24701.3 24747.5 6516.1 6576.1 6580.6 6586.3 6591.2 6448.4 6473.7 6479.8 6532.9 6542.1 6313.0 6593.2 6618.2 6619.5 6628.8 6526.7 6554.6 6559.0 6614.3 6651.7 5816.1 6047.2 6058.0 6094.5 6146.9 28227.6 28680.0 28687.9 28733.4 28743.9 2036.8 2060.2 2061.0 2061.8 2062.2 17982.5 18596.3 18762.0 18858.6 18877.5 2389.4 2447.8 2451.4 2455.5 2469.5 119139.4 124064.4 125350.0 136346.0 142039.3 13979.0 14061.4 14388.4 14461.6 14480.6 22419.9 22527.9 22560.7 22575.8 22665.1 9302.9 9566.4 9632.1 9769.9 9952.9 9140.8 9157.9 9169.7 9203.7 9263.2 8765.8 8777.1 8837.9 8925.4 8955.1 2543.3 2629.7 2656.5 2661.4 2702.0 959.4 960.8 967.1 974.0 986.6 18549.9 18666.9 19043.9 19145.2 19209.1 1024.6 1027.8 1029.7 1039.7 1042.4 10250.7 10464.2 10592.1 10620.3 10627.1 457819.0 467556.0 469938.0 472658.0 484909.0 108963.5 109061.0 109623.0 110875.4 111780.0 1149.3 1155.5 1235.4 1237.9 1248.8 19634.4 19689.2 19960.6 20199.4 20257.8 52967.0 55639.7 56041.2 56264.0 56557.0 66851.0 68194.0 69665.0 70000.0 70806.6 13980.4 14006.9 14131.6 14207.1 14376.8 22062.7 22244.2 22409.8 22550.9 22628.9 17685.6 17686.4 17748.2 17983.9 18007.4 15622.4 16045.2 16424.1 16514.3 16777.2 18536.0 18549.3 18642.8 18703.2 18772.8 12957.8 13983.6 13989.9 14033.0 14082.5 17426.0 17716.1 17720.7 17783.9 17933.0 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | [#3] mootools.html Cycles:180 Average:9496.47 Median:2655.45 stddev:6791.67 (255.8%) stddev-sans-first:6782.64 03:06:10 INFO - PID 17975 | Values: 1277.4 1370.5 1371.8 1385.9 1390.1 14994.4 15609.9 15637.1 15645.5 15657.6 15232.8 15461.9 15480.2 15535.8 15611.4 2703.7 2815.9 2819.4 2820.2 2821.8 2730.9 2743.8 2754.2 2775.2 2775.6 2681.7 2710.2 2755.1 2756.4 2757.2 2565.4 2633.4 2641.1 2642.5 2644.2 2634.6 2651.8 2652.1 2658.8 2664.5 14748.9 14761.3 14787.5 14918.9 14990.8 7908.0 8222.7 8236.1 8274.8 8275.9 5355.3 5497.5 5622.6 5651.4 5692.1 1868.5 1877.5 1882.3 1900.8 1943.1 23783.6 25089.2 26011.9 27212.6 27251.2 7251.0 7291.3 7366.5 7431.9 7485.4 20186.9 20217.7 20258.9 20270.6 20296.7 8398.9 8506.2 8506.7 8519.5 8521.5 6909.7 7329.0 7345.6 7397.7 7591.6 5491.7 5704.1 5718.1 5734.8 5746.6 1746.3 1772.3 1793.3 1813.9 1827.4 880.1 893.2 911.3 916.3 925.5 7370.2 7395.4 7417.1 7422.6 7448.6 708.0 708.0 712.9 714.9 722.8 4518.6 4599.9 4610.3 4613.5 4618.8 21055.9 21598.5 22041.3 22146.7 22250.4 21140.4 21413.4 21730.0 21772.8 21832.8 10173.0 10351.8 10386.6 10480.1 10530.2 8473.5 8533.1 8596.4 8622.7 8670.7 18602.9 18871.0 18921.9 19241.2 19431.9 19012.0 19019.5 19587.4 19609.1 20096.1 11735.4 11891.6 11953.9 11990.2 12002.8 13527.3 13771.7 13922.9 14010.4 14025.6 11371.1 11894.5 11923.6 11935.6 11953.5 11323.7 11406.2 11456.5 11488.3 11598.1 9622.0 9760.2 9824.1 9893.7 9896.6 7505.9 7572.4 7691.0 7697.8 7855.4 7717.2 7760.6 7772.8 7816.3 7826.1 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | [#4] prototype.html Cycles:180 Average:5480.96 Median:6135.61 stddev:1529.60 (24.9%) stddev-sans-first:1487.35 03:06:10 INFO - PID 17975 | Values: 492.3 503.3 523.4 527.6 537.1 6010.8 6193.2 6224.1 6234.8 6259.0 6143.8 6183.9 6183.9 6189.9 6191.7 5188.0 5214.8 5216.8 5217.6 5242.5 4867.7 5008.7 5043.5 5048.2 5122.6 5014.2 5019.7 5022.7 5033.8 5037.7 4868.1 4996.0 4996.7 5010.1 5026.9 4392.7 4449.7 4453.4 4459.2 4497.6 6025.3 6087.8 6113.8 6147.2 6161.5 5686.7 5714.9 5762.8 5777.6 5792.6 6503.7 6520.4 6565.6 6629.2 6645.2 4753.9 4827.6 4855.7 4856.3 4861.8 6803.3 6906.3 6918.8 6925.5 6975.0 4954.8 5062.7 5075.2 5075.6 5102.1 5055.5 5057.8 5066.7 5081.8 5145.5 5615.8 5649.5 5661.3 5688.9 5743.1 6534.7 6602.3 6663.9 6678.0 6680.7 1633.4 1680.0 1684.7 1692.7 1746.1 1188.3 1211.9 1245.6 1246.5 1248.7 5574.2 5604.3 5713.3 5731.1 5753.3 6492.7 6499.7 6501.3 6506.6 6589.7 5531.5 5682.1 5686.4 5728.9 5733.5 3481.9 3489.8 3509.6 3539.6 3543.7 6115.5 6338.9 6344.6 6360.8 6408.2 6827.8 6828.5 6855.5 6884.4 6890.7 6272.2 6298.9 6372.6 6412.3 6416.5 6572.9 6574.6 6664.2 6681.2 6695.8 6491.8 6519.2 6532.8 6616.7 6623.7 6283.5 6335.2 6340.9 6346.0 6382.6 4852.1 4925.0 4964.2 4976.7 4979.1 6661.0 6667.6 6691.9 6713.4 6715.7 6412.6 6438.5 6521.0 6536.2 6544.3 6395.0 6434.5 6547.5 6558.7 6608.9 6132.6 6236.9 6318.9 6351.4 6476.6 6138.6 6495.2 6521.3 6546.3 6629.2 6351.7 6379.1 6379.7 6402.3 6445.8 03:06:10 INFO - PID 17975 | 03:06:10 INFO - PID 17975 | [#5] yui.html Cycles:180 Average:24669.66 Median:20229.34 stddev:34752.14 (171.8%) stddev-sans-first:34803.85 03:06:10 INFO - PID 17975 | Values: 912.0 933.5 940.9 947.2 950.9 19553.1 20185.1 20273.6 20285.2 20342.1 18834.6 19143.2 19191.2 19209.2 19216.3 936.6 946.3 950.4 951.4 951.4 967.2 969.2 969.8 975.3 976.8 989.5 1020.7 1043.7 1046.8 1052.2 1036.2 1037.4 1039.4 1039.9 1040.6 719.6 744.4 748.6 755.8 756.5 19046.6 19434.4 19533.6 19636.8 19724.0 21023.4 21100.8 21535.5 21586.7 21662.1 17275.7 17577.0 17601.9 17639.3 17712.6 3802.0 3816.8 3826.8 3831.6 3833.8 108051.6 143791.0 149445.3 149732.0 150527.0 16819.9 17091.9 17246.1 17250.7 17323.6 31798.5 32405.2 32446.4 32645.8 32652.3 8751.7 9124.6 9145.0 9155.0 9336.0 4269.9 4321.3 4333.3 4335.0 4341.7 5499.3 5586.8 5590.1 5641.3 5672.6 1078.6 1083.2 1099.8 1101.3 1109.6 688.6 701.3 708.4 711.6 713.4 11956.6 12849.3 13054.7 13209.7 13535.7 706.7 710.9 720.0 730.2 736.1 5917.5 5941.7 5978.7 6007.9 6106.5 118229.4 120731.0 121806.0 122537.0 123989.0 86163.1 100563.0 105473.5 113055.4 115418.0 91288.0 92337.0 93171.5 94271.5 95470.5 12942.4 13188.9 13195.7 13210.0 13338.9 40104.0 41025.6 41043.8 42485.4 43356.1 54960.5 55353.4 55961.4 56348.0 56521.2 18344.5 18477.2 18489.8 18529.4 18991.3 20004.8 20775.2 20789.6 20938.0 21234.7 17483.6 18298.2 18585.5 18676.7 18688.0 17388.4 17525.4 17707.6 17847.8 17898.2 17634.6 17937.0 17993.6 18037.4 18193.8 13347.6 13475.4 13480.9 13581.9 14077.7 14095.2 14217.8 14264.7 14324.2 14389.6 03:06:10 INFO - PID 17975 | -------- Summary: end -------- 03:06:10 INFO - PID 17975 | 03:06:10 INFO - TEST-INFO | 17975: exit 0 03:06:10 INFO - TEST-OK | dromaeo_css | took 1112473ms 03:06:10 INFO - TEST-START | kraken 03:06:10 INFO - Initialising browser for kraken test... 03:06:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40306/getInfo.html -profile /tmp/tmpewM5r7/profile 03:06:10 INFO - TEST-INFO | started process 18360 (/builds/slave/test/build/application/firefox/firefox http://localhost:40306/getInfo.html) 03:06:17 INFO - TEST-INFO | 18360: exit 0 03:06:17 INFO - Browser initialized. 03:06:17 INFO - Running cycle 1/1 for kraken test... 03:06:17 INFO - Using env: {'DISPLAY': ':0', 03:06:17 INFO - 'HOME': '/home/cltbld', 03:06:17 INFO - 'JSGC_DISABLE_POISONING': '1', 03:06:17 INFO - 'LANG': 'en_US.UTF-8', 03:06:17 INFO - 'LANGUAGE': 'en_US:en', 03:06:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:06:17 INFO - 'LOGNAME': 'cltbld', 03:06:17 INFO - 'MAIL': '/var/mail/cltbld', 03:06:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:06:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:06:17 INFO - 'MOZ_ACCELERATED': '1', 03:06:17 INFO - 'MOZ_CRASHREPORTER': '1', 03:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:06:17 INFO - 'MOZ_NO_REMOTE': '1', 03:06:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:06:17 INFO - 'MOZ_WEBRENDER': '1', 03:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:17 INFO - 'NO_EM_RESTART': '1', 03:06:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:17 INFO - 'PWD': '/builds/slave/test', 03:06:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:06:17 INFO - 'RUST_BACKTRACE': 'full', 03:06:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:06:17 INFO - 'SHELL': '/bin/bash', 03:06:17 INFO - 'SHLVL': '1', 03:06:17 INFO - 'TERM': 'linux', 03:06:17 INFO - 'TMOUT': '86400', 03:06:17 INFO - 'USER': 'cltbld', 03:06:17 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505546407.535171-7488871', 03:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:17 INFO - '_': '/tools/buildbot/bin/python'} 03:06:17 INFO - TEST-INFO | started process 18604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewM5r7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:18 INFO - PID 18604 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:06:18 INFO - PID 18604 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:06:18 INFO - PID 18604 | 03:06:18 INFO - PID 18604 | (/builds/slave/test/build/application/firefox/firefox:18663): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:06:18 INFO - PID 18604 | 03:06:28 INFO - PID 18604 | RSS: Main: 194568192 03:06:28 INFO - PID 18604 | 03:06:31 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40306/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:32 INFO - PID 18604 | RSS: Main: 199311360 03:06:32 INFO - PID 18604 | 03:06:35 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40306/tests/kraken/driver.html?testName=audio-dft) 03:06:35 INFO - PID 18604 | RSS: Main: 201428992 03:06:35 INFO - PID 18604 | 03:06:38 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40306/tests/kraken/driver.html?testName=audio-fft) 03:06:39 INFO - PID 18604 | RSS: Main: 196468736 03:06:39 INFO - PID 18604 | 03:06:41 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40306/tests/kraken/driver.html?testName=audio-oscillator) 03:06:42 INFO - PID 18604 | RSS: Main: 196808704 03:06:42 INFO - PID 18604 | 03:06:44 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:45 INFO - PID 18604 | RSS: Main: 198418432 03:06:45 INFO - PID 18604 | 03:06:48 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40306/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:49 INFO - PID 18604 | RSS: Main: 200413184 03:06:49 INFO - PID 18604 | 03:06:52 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40306/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:53 INFO - PID 18604 | RSS: Main: 199208960 03:06:53 INFO - PID 18604 | 03:06:56 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40306/tests/kraken/driver.html?testName=json-parse-financial) 03:06:57 INFO - PID 18604 | RSS: Main: 200142848 03:06:57 INFO - PID 18604 | 03:06:58 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:59 INFO - PID 18604 | RSS: Main: 199634944 03:06:59 INFO - PID 18604 | 03:07:01 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:07:01 INFO - PID 18604 | RSS: Main: 200151040 03:07:01 INFO - PID 18604 | 03:07:03 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:07:04 INFO - PID 18604 | RSS: Main: 200777728 03:07:04 INFO - PID 18604 | 03:07:07 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:07:07 INFO - PID 18604 | RSS: Main: 201142272 03:07:07 INFO - PID 18604 | 03:07:10 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:11 INFO - PID 18604 | RSS: Main: 201125888 03:07:11 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | Cycle 1(1): loaded http://localhost:40306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40306/tests/kraken/driver.html?testName=ai-astar) 03:07:13 INFO - PID 18604 | RSS: Main: 203599872 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | __start_tp_report 03:07:13 INFO - PID 18604 | _x_x_mozilla_page_load 03:07:13 INFO - PID 18604 | _x_x_mozilla_page_load_details 03:07:13 INFO - PID 18604 | |i|pagename|runs| 03:07:13 INFO - PID 18604 | |0;ai-astar;119;109;116;113;108;115;118;109;118;107 03:07:13 INFO - PID 18604 | |1;audio-beat-detection;121;117;121;117;123;115;149;124;126;122 03:07:13 INFO - PID 18604 | |2;audio-dft;168;164;165;164;168;163;169;171;165;163 03:07:13 INFO - PID 18604 | |3;audio-fft;79;86;81;80;79;76;74;75;78;93 03:07:13 INFO - PID 18604 | |4;audio-oscillator;100;84;85;79;84;87;86;86;81;79 03:07:13 INFO - PID 18604 | |5;imaging-gaussian-blur;113;117;115;113;120;116;114;114;118;118 03:07:13 INFO - PID 18604 | |6;imaging-darkroom;153;150;152;148;149;150;149;149;159;151 03:07:13 INFO - PID 18604 | |7;imaging-desaturate;101;96;95;95;95;95;94;95;94;98 03:07:13 INFO - PID 18604 | |8;json-parse-financial;57;58;54;57;57;54;57;56;55;57 03:07:13 INFO - PID 18604 | |9;json-stringify-tinderbox;45;44;45;40;49;45;46;38;48;45 03:07:13 INFO - PID 18604 | |10;stanford-crypto-aes;81;79;78;77;85;81;79;85;75;77 03:07:13 INFO - PID 18604 | |11;stanford-crypto-ccm;120;117;111;112;115;111;113;116;110;119 03:07:13 INFO - PID 18604 | |12;stanford-crypto-pbkdf2;170;171;165;167;172;179;168;169;178;166 03:07:13 INFO - PID 18604 | |13;stanford-crypto-sha256-iterative;78;75;64;67;66;71;69;78;64;62 03:07:13 INFO - PID 18604 | __end_tp_report 03:07:13 INFO - PID 18604 | __start_cc_report 03:07:13 INFO - PID 18604 | _x_x_mozilla_cycle_collect,978 03:07:13 INFO - PID 18604 | __end_cc_report 03:07:13 INFO - PID 18604 | __startTimestamp1505556433684__endTimestamp 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | ------- Summary: start ------- 03:07:13 INFO - PID 18604 | Number of tests: 14 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#0] ai-astar Cycles:10 Average:113.20 Median:115.50 stddev:4.61 (4.0%) stddev-sans-first:4.39 03:07:13 INFO - PID 18604 | Values: 119.0 109.0 116.0 113.0 108.0 115.0 118.0 109.0 118.0 107.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:122.50 stddev:9.59 (7.8%) stddev-sans-first:10.13 03:07:13 INFO - PID 18604 | Values: 121.0 117.0 121.0 117.0 123.0 115.0 149.0 124.0 126.0 122.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.50 stddev:2.79 (1.7%) stddev-sans-first:2.86 03:07:13 INFO - PID 18604 | Values: 168.0 164.0 165.0 164.0 168.0 163.0 169.0 171.0 165.0 163.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#3] audio-fft Cycles:10 Average:80.10 Median:79.50 stddev:5.67 (7.1%) stddev-sans-first:6.00 03:07:13 INFO - PID 18604 | Values: 79.0 86.0 81.0 80.0 79.0 76.0 74.0 75.0 78.0 93.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:84.50 stddev:5.97 (7.1%) stddev-sans-first:3.05 03:07:13 INFO - PID 18604 | Values: 100.0 84.0 85.0 79.0 84.0 87.0 86.0 86.0 81.0 79.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.50 stddev:2.39 (2.1%) stddev-sans-first:2.32 03:07:13 INFO - PID 18604 | Values: 113.0 117.0 115.0 113.0 120.0 116.0 114.0 114.0 118.0 118.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:150.50 stddev:3.20 (2.1%) stddev-sans-first:3.31 03:07:13 INFO - PID 18604 | Values: 153.0 150.0 152.0 148.0 149.0 150.0 149.0 149.0 159.0 151.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.15 (2.3%) stddev-sans-first:1.20 03:07:13 INFO - PID 18604 | Values: 101.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 98.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.40 (2.5%) stddev-sans-first:1.45 03:07:13 INFO - PID 18604 | Values: 57.0 58.0 54.0 57.0 57.0 54.0 57.0 56.0 55.0 57.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#9] json-stringify-tinderbox Cycles:10 Average:44.50 Median:45.00 stddev:3.31 (7.4%) stddev-sans-first:3.50 03:07:13 INFO - PID 18604 | Values: 45.0 44.0 45.0 40.0 49.0 45.0 46.0 38.0 48.0 45.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:3.33 (4.2%) stddev-sans-first:3.50 03:07:13 INFO - PID 18604 | Values: 81.0 79.0 78.0 77.0 85.0 81.0 79.0 85.0 75.0 77.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:115.50 stddev:3.53 (3.1%) stddev-sans-first:3.11 03:07:13 INFO - PID 18604 | Values: 120.0 117.0 111.0 112.0 115.0 111.0 113.0 116.0 110.0 119.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.50 stddev:4.74 (2.8%) stddev-sans-first:5.03 03:07:13 INFO - PID 18604 | Values: 170.0 171.0 165.0 167.0 172.0 179.0 168.0 169.0 178.0 166.0 03:07:13 INFO - PID 18604 | 03:07:13 INFO - PID 18604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:5.89 (8.4%) stddev-sans-first:5.36 03:07:13 INFO - PID 18604 | Values: 78.0 75.0 64.0 67.0 66.0 71.0 69.0 78.0 64.0 62.0 03:07:13 INFO - PID 18604 | -------- Summary: end -------- 03:07:13 INFO - PID 18604 | 03:07:14 INFO - PID 18604 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:07:14 INFO - TEST-INFO | 18604: exit 0 03:07:14 INFO - TEST-OK | kraken | took 63627ms 03:07:14 INFO - SUITE-END | took 1176s 03:07:14 INFO - Completed test suite (00:19:36) 03:07:14 INFO - javascript benchmark 03:07:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8531.082457879156, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.29452225988, 3098.4422803895295, 3101.333213359129, 3115.5949726535546, 3121.422536830685, 6092.390760923905, 6178.413050760176, 6195.442410183083, 6249.062640603912, 6348.587341822778, 6180.381961803817, 6233.844153896155, 6334.746610135589, 6387.361263873622, 6408.519361047916, 5651.7739290428335, 5724.0, 5757.337906140785, 5817.476427121558, 5839.211706419643, 5717.571182161334, 5783.392743761908, 5871.559633027518, 5888.057910734284, 5890.88218235635, 5657.264555607786, 5708.571857110713, 5729.885402291972, 5748.511376533, 5859.44335288147, 5578.079616863253, 5633.0987042073075, 5721.513671337942, 5759.0, 5799.82600521985, 5674.546036317085, 5745.2243947067445, 5751.568632352591, 5755.251817263771, 5757.0, 6232.844178895519, 6257.124002639634, 6320.905186422207, 6341.2707538633185, 6365.968170159166, 6536.509761767887, 6622.801315960481, 6632.900506492407, 6695.631740254284, 6781.050652908597, 6696.665166741644, 6737.292584278629, 6770.492213084039, 6781.593104413751, 6808.2170550386345, 6022.879542409128, 6268.968655156695, 6281.277653069909, 6286.591371560834, 6303.747850086037, 6793.218779840382, 6886.345797149263, 6897.206821215625, 6998.055262539492, 7042.753503627451, 6584.86830263392, 6649.767258145942, 6652.135222421151, 6695.263521012685, 6733.8653226935185, 6654.168228971379, 6739.056532085512, 6759.493038022168, 6826.180858297036, 6840.863182736317, 6436.967815160894, 6615.239247486601, 6664.067030615718, 6745.291744366869, 6800.455963522906, 6743.055972163901, 6748.527603067738, 6765.695543700545, 6768.56004359715, 6776.356246156607, 5266.1574148136115, 5269.604779641542, 5278.868028299324, 5279.102552566073, 5322.680639161663, 4561.612262957619, 4616.007558374966, 4631.3516107744945, 4657.347971284023, 4678.906421871611, 5640.379558248589, 5770.596058275881, 5770.913436298459, 5816.0, 5818.709064546756, 6663.500237482208, 6708.899366509506, 6792.354726300993, 6808.421284190899, 6819.795406137824, 5735.0, 5757.913631295534, 5796.391378905154, 5806.361300256968, 5839.445252701072, 5792.131180322901, 5829.679367634736, 5867.413258674183, 5868.09044598088, 5879.235699359056, 6485.1245081914285, 6486.254080780676, 6509.121268628769, 6577.967110164419, 6590.340965903371, 6588.868222635425, 6676.265610782907, 6741.898871516931, 6754.831129221612, 6836.28219036994, 6439.903401449075, 6468.676566171766, 6521.217453905561, 6570.211574611078, 6577.934220657732, 6668.83327916806, 6735.057092007025, 6739.629320387229, 6741.258461569321, 6767.289434609492, 6780.593164410151, 6791.694373753094, 6801.761938332134, 6888.7244510221035, 6889.552179108342, 6379.043143528323, 6568.573042752206, 6570.967145164243, 6617.2721000688925, 6668.933310666831, 6360.173177486897, 6408.679566021587, 6580.1116849226655, 6597.967010164918, 6598.8350291243105, 6463.15978922737, 6482.157319548429, 6539.019147127969, 6542.869142617216, 6582.0, 6569.310222426577, 6612.603243805387, 6615.272320044695, 6659.600423974577, 6669.633170175687, 6221.782237621843, 6362.872742545031, 6390.748931333585, 6467.676616169078, 6481.837954051187], "value": 6125.942584461756, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.3575282785083, 859.4070091636775, 885.982280354393, 887.3344991256556, 889.3196704521039, 38821.80589097054, 42539.14921701568, 42581.0, 42715.0, 42829.35755963663, 38725.61274387255, 39309.80345098278, 39313.213735725265, 39315.80342098293, 39374.21251574967, 6962.721491140348, 7120.465965052642, 7121.715131394738, 7121.928780712205, 7124.5725256484775, 7022.648867556627, 7099.645017749118, 7103.644817759117, 7108.573485590881, 7112.85774284514, 7080.964595177017, 7093.822654433655, 7097.645117744118, 7107.644617769117, 7112.075430194068, 7624.313811756941, 7815.882761758578, 7824.21757824213, 7852.842943141134, 7859.292663660298, 7660.080790305144, 7672.884906726348, 7757.9224207758325, 7806.72676456327, 7831.8433631327625, 37289.440658390144, 37895.621043789484, 37897.62102378969, 37902.62097379019, 38949.0, 3578.9284214315567, 3597.8560857565926, 3613.403788374915, 3615.2227271136567, 3622.2755448910325, 32733.18167045819, 32819.0, 32867.34265314704, 33092.503612445835, 33108.17229569256, 5228.372595288552, 5230.92153617696, 5248.580113590941, 5278.762455689503, 5288.286081379003, 185984.0, 187855.0, 187932.06033969743, 188274.0, 189561.99999999863, 43382.34926476042, 43794.343084853754, 49174.754126229855, 49654.751726241135, 49904.251436228486, 45504.317435238496, 45657.54342456599, 52471.73764131231, 52643.0, 52695.0, 15693.215339232993, 15785.0, 15820.367185312689, 15919.681606367807, 15966.121863297398, 12710.364481775874, 12773.425195866208, 12830.422630981628, 12845.550405735754, 12855.292958887165, 14332.283385830875, 14372.281385930663, 14394.712105757826, 14456.494022709154, 14493.275336233146, 5749.310082790092, 5848.502877255481, 5851.707414629252, 5963.344032156459, 5979.133025711248, 1010.3483253301579, 1014.2038499777639, 1028.141501845967, 1030.299396410433, 1037.823569993103, 23076.0, 23629.527409452057, 23794.64308035381, 23820.52358952811, 23921.043158273475, 1086.163653986426, 1099.9450027498592, 1110.5169251375678, 1123.921325507223, 1136.267107715519, 12336.198147120409, 12483.126181167412, 12504.0, 12670.429830657642, 12715.809262861065, 219840.0, 220079.0, 220291.0, 221079.0, 221830.0, 53261.467385326425, 53399.46600533945, 53532.73233633885, 53636.73181634067, 54096.18855717168, 1382.585224432666, 1445.5374280230226, 1459.9708005839823, 1463.9048461849945, 1477.1284941884126, 22936.0, 23082.538349232585, 23137.652935206323, 23238.125658160665, 23819.761802382447, 37220.06949826276, 37537.81231093827, 37593.62406376011, 37644.81177594094, 37668.62331376651, 143091.28454357662, 143116.0, 143370.0, 143611.0, 143744.0, 32988.0, 35548.28903421865, 35617.64382356143, 35911.0, 35976.64023359837, 43179.35230971475, 43438.13123737571, 43868.78065609652, 44312.0, 44740.55259447494, 31990.84004579962, 32245.0, 32318.83840580782, 32543.837280813445, 32678.0, 31060.0, 31380.37239255248, 31490.685093148775, 31541.21146971252, 31938.36123277475, 35474.290514190085, 35599.0, 35858.4621230687, 35942.640573593926, 35961.0, 30757.692423076376, 30769.846150769103, 30807.075787726404, 30990.845045774626, 31284.37431251408, 23228.070877164722, 23575.0, 23605.763942360358, 23681.0, 23696.52606947886], "value": 16914.97445920643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.210187838904, 572.530524969525, 573.5268403567055, 574.7241324164398, 586.6069733278703, 22544.54910901781, 23368.298951031455, 23403.0, 23418.648720269168, 23451.882740586316, 23409.0, 24290.271291861274, 24518.877405612948, 24701.270911036234, 24747.50504989899, 6516.087747715312, 6576.0793488911595, 6580.5722628029025, 6586.27550969393, 6591.209054913417, 6448.419642232222, 6473.6763161841955, 6479.838004049913, 6532.934670653304, 6542.1495205623205, 6312.968435157841, 6593.20881494219, 6618.238902526223, 6619.536632435707, 6628.834279143036, 6526.673666316665, 6554.5739526931075, 6558.967205163967, 6614.305497922721, 6651.667416629173, 5816.127580862904, 6047.213862197887, 6057.969710151465, 6094.481969032638, 6146.907796383058, 28227.57658635122, 28680.0, 28687.85656071727, 28733.425331493254, 28743.85628071846, 2036.8370530357536, 2060.1553363121197, 2061.0313152818153, 2061.845361597886, 2062.1957436599587, 17982.460526184237, 18596.256149753994, 18762.0, 18858.62282754351, 18877.528061798428, 2389.3548741839604, 2447.7674620910984, 2451.350392146083, 2455.4966231922413, 2469.4814089041324, 119139.4043029788, 124064.37967810193, 125350.0, 136346.0, 142039.28980355136, 13979.0, 14061.367238474293, 14388.352524136439, 14461.638459038399, 14480.637984050483, 22419.887900560392, 22527.88736056342, 22560.66159007616, 22575.774242257696, 22665.093396264296, 9302.86045709315, 9566.426014439156, 9632.133108020313, 9769.90230097704, 9952.850707239397, 9140.817183656289, 9157.862632060524, 9169.679061232824, 9203.677871274473, 9263.16631503168, 8765.780855478537, 8777.122287771172, 8837.867431988525, 8925.36701673008, 8955.104489551122, 2543.2649375657775, 2629.6581444412104, 2656.455426637535, 2661.4450127877453, 2701.986490067537, 959.3859929645033, 960.8277900960817, 967.086103632075, 973.9659111931048, 986.5560497775886, 18549.90725046366, 18666.906665466584, 19043.90478047601, 19145.234190632218, 19209.135588898534, 1024.6248518824577, 1027.768752030787, 1029.7271223125729, 1039.656913218636, 1042.3745752548562, 10250.692479225636, 10464.21518386124, 10592.099671528007, 10620.256582039183, 10627.09669678086, 457819.0, 467556.0, 469938.0, 472658.0, 484909.0, 108963.45518272358, 109061.0, 109623.0, 110875.44562277137, 111780.0, 1149.2816989381636, 1155.5262342439728, 1235.43170141734, 1237.9442925068213, 1248.7502499499954, 19634.410967670992, 19689.21243150258, 19960.60078798445, 20199.39401817948, 20257.797422025593, 52967.0, 55639.72180139073, 56041.15938261011, 56264.0, 56557.0, 66851.0, 68194.0, 69665.0, 70000.0, 70806.64596676984, 13980.370883310072, 14006.859931400555, 14131.64670883236, 14207.147571145764, 14376.784348234576, 22062.669059964435, 22244.221452249094, 22409.77590224077, 22550.887245563667, 22628.886855566274, 17685.55786105306, 17686.380976665754, 17748.201330940396, 17983.910080449514, 18007.369742058963, 15622.375104995674, 16045.19774011318, 16424.09667468253, 16514.25685844116, 16777.161141942608, 18536.0, 18549.258029678662, 18642.81357186465, 18703.1583578742, 18772.812271877654, 12957.805632915326, 13983.580492585239, 13989.860101398855, 14033.0, 14082.507112251022, 17426.0, 17716.11419429049, 17720.734188987433, 17783.911080444515, 17933.0], "value": 11751.080989358314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.36131934033, 1370.506617617657, 1371.801088842118, 1385.9376328065243, 1390.1103293891908, 14994.40022399104, 15609.921950390231, 15637.061776293416, 15645.452409165682, 15657.608559786011, 15232.771508427382, 15461.92269038656, 15480.225988700577, 15535.844641553582, 15611.375544978187, 2703.716109808466, 2815.8873645054277, 2819.407924335892, 2820.2244382794693, 2821.7883658725573, 2730.9044183453584, 2743.8353698778037, 2754.2425832895915, 2775.2368098772795, 2775.5559110542317, 2681.6647919010124, 2710.159850446358, 2755.118362124121, 2756.4349308391834, 2757.2279761666764, 2565.3586603349163, 2633.4074833162576, 2641.075623531758, 2642.4979253941688, 2644.2331723800266, 2634.6048092786045, 2651.814372993891, 2652.0585192256663, 2658.8404695718127, 2664.5203863304596, 14748.926255368655, 14761.33573989173, 14787.482438114614, 14918.850811491855, 14990.775138372825, 7908.0, 8222.712205072854, 8236.094029656733, 8274.751757447286, 8275.875861862016, 5355.250264962909, 5497.47773961473, 5622.57830662702, 5651.378348381675, 5692.0608099663505, 1868.4955062133147, 1877.483691984715, 1882.3223639489772, 1900.7624046994126, 1943.0867492278749, 23783.643245351333, 25089.24732258035, 26011.869940650366, 27212.59181112285, 27251.182464526097, 7250.9637451812405, 7291.270872912773, 7366.521176123535, 7431.888521672179, 7485.438592105614, 20186.899065504578, 20217.696734548994, 20258.885761283273, 20270.594588108157, 20296.695549566768, 8398.916010839814, 8506.191911768372, 8506.74479765608, 8519.531425771642, 8521.488710677379, 6909.689063992132, 7328.963355183297, 7345.55926644403, 7397.667104980289, 7591.62041897914, 5491.65454463651, 5704.1443783432815, 5718.056520674126, 5734.827955161269, 5746.626469279484, 1746.336392170967, 1772.2556526259002, 1793.3006127610242, 1813.86396020299, 1827.4060930197472, 880.097899652861, 893.2273583350355, 911.3210658059788, 916.2852974679761, 925.5418567808844, 7370.226126256773, 7395.4083673306, 7417.10994680631, 7422.620653814275, 7448.553086814808, 707.9575225486487, 708.0370695853635, 712.9251428599922, 714.9356557909813, 722.8301349182938, 4518.593326600621, 4599.862004139881, 4610.262358022767, 4613.492515823256, 4618.815247390134, 21055.8947205263, 21598.460038499165, 22041.338759837232, 22146.667799983014, 22250.443738906655, 21140.365789026353, 21413.357599272047, 21730.0, 21772.782272177392, 21832.78167218339, 10173.0, 10351.792964140675, 10386.584536618602, 10480.056794888344, 10530.21023423231, 8473.5339556325, 8533.146685331665, 8596.35527335465, 8622.698205562776, 8670.739877803677, 18602.906985464986, 18871.0, 18921.90539047296, 19241.230350785812, 19431.902840485705, 19012.049397530343, 19019.524511887314, 19587.412377628694, 19609.11758970821, 20096.095675694338, 11735.41322933867, 11891.643250702493, 11953.940230298793, 11990.160688751703, 12002.819957700467, 13527.256000920044, 13771.724565508433, 13922.930385348009, 14010.369533371226, 14025.579232623038, 11371.090312774793, 11894.464749086485, 11923.642290731292, 11935.582254621047, 11953.521859125538, 11323.716907077389, 11406.201565890307, 11456.484458199568, 11488.310701357945, 11598.07215422781, 9621.951890240503, 9760.219182465527, 9824.06671366219, 9893.703188904345, 9896.554655040685, 7505.949167116717, 7572.432067594842, 7691.038620172479, 7697.769066928001, 7855.37157027425, 7717.151113377637, 7760.611969401621, 7772.805679858049, 7816.335611473089, 7826.139124696165], "value": 6736.3904726080145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.3107649290992, 503.29287351271455, 523.3941316415544, 527.588480984832, 537.0655060195259, 6010.819675409739, 6193.163922870411, 6224.128621992924, 6234.812955611339, 6259.0, 6143.846403839906, 6183.907241391383, 6183.938160618392, 6189.876202475959, 6191.678120704736, 5187.976689091258, 5214.791408343662, 5216.843494695147, 5217.556507696831, 5242.501962313593, 4867.707937523742, 5008.724520151391, 5043.470435604264, 5048.242763585473, 5122.564582010534, 5014.24786282057, 5019.723915184663, 5022.748862556876, 5033.823816166435, 5037.697738135706, 4868.123737727207, 4995.950040499585, 4996.650234483587, 5010.148274793276, 5026.949730502684, 4392.692511524195, 4449.688521803475, 4453.37652728615, 4459.197344477992, 4497.617702495292, 6025.307089684698, 6087.817365479043, 6113.847153821145, 6147.170132032164, 6161.476274516672, 5686.744096515626, 5714.914276285859, 5762.818622182443, 5777.566682498829, 5792.623479473821, 6503.707333169971, 6520.43569501351, 6565.638889861056, 6629.204495460527, 6645.235797883257, 4753.904921901577, 4827.637927155477, 4855.708657480527, 4856.3201151838775, 4861.83980412731, 6803.319668033207, 6906.309369063053, 6918.792436226921, 6925.515213935027, 6975.0, 4954.801807927643, 5062.670926389773, 5075.2387141929, 5075.593952483792, 5102.132637451642, 5055.51972562606, 5057.848264552069, 5066.746662666926, 5081.8475445736685, 5145.536901678867, 5615.803446879421, 5649.548036157097, 5661.348944871393, 5688.914666280009, 5743.0811070228565, 6534.705938232791, 6602.3067577904585, 6663.933360666429, 6678.0, 6680.732770689216, 1633.4364644197733, 1679.9748003779953, 1684.6967545841621, 1692.7122389193867, 1746.0658547676933, 1188.304841667634, 1211.939403029845, 1245.6325384011739, 1246.5450110709526, 1248.6951136062837, 5574.1917421973585, 5604.299462567179, 5713.285839270091, 5731.140328950691, 5753.311051493103, 6492.67536623167, 6499.707513161919, 6501.284858665543, 6506.640550830954, 6589.705147426287, 5531.502164805187, 5682.1021279147935, 5686.3744988051285, 5728.885422291531, 5733.483986441241, 3481.9303613928087, 3489.7557170998293, 3509.6139424663265, 3539.592946811098, 3543.6987856032524, 6115.480184184395, 6338.936610633927, 6344.58760180596, 6360.777372792023, 6408.231012278557, 6827.761028364082, 6828.5220034597105, 6855.520113592101, 6884.4148247399535, 6890.655467226718, 6272.153259309935, 6298.905516417258, 6372.58578192416, 6412.2625898022325, 6416.486681065504, 6572.934270657232, 6574.572652777745, 6664.166979127609, 6681.164854393201, 6695.765648202484, 6491.837704057436, 6519.23980525246, 6532.804015879531, 6616.676664666989, 6623.701933412912, 6283.5287353449585, 6335.176427064452, 6340.904886426615, 6346.048092785934, 6382.5532212744665, 4852.126617208936, 4924.975375123101, 4964.205727083649, 4976.701397916137, 4979.0788704089855, 6661.0, 6667.599944003181, 6691.933080669131, 6713.395794378529, 6715.731370745116, 6412.583182093149, 6438.549301548846, 6521.0, 6536.182977127859, 6544.312847150981, 6394.968025159845, 6434.453071488976, 6547.476201903741, 6558.672066396756, 6608.909529927508, 6132.62016046386, 6236.937630623635, 6318.8736225274315, 6351.396617321347, 6476.6114033158165, 6138.6009909357535, 6495.220573531206, 6521.347865213441, 6546.345365463416, 6629.171353580802, 6351.650659213788, 6379.086274117839, 6379.7129129190225, 6402.295747467868, 6445.807525607777], "value": 5030.221255291272, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.9908800911991, 933.4772527384661, 940.8541676040212, 947.1617618407712, 950.9144177024067, 19553.120109595067, 20185.091670874826, 20273.59452810943, 20285.188592456285, 20342.08460619272, 18834.623307533842, 19143.234270629157, 19191.23235070599, 19209.231630734754, 19216.327428540004, 936.6347124621403, 946.3139224062551, 950.353759443578, 951.3720944176845, 951.4243882451121, 967.2165545907802, 969.2488321550819, 969.8351280282369, 975.3172779054655, 976.7851072763981, 989.534918588266, 1020.6784862768242, 1043.6660268714015, 1046.785408991155, 1052.2318707343643, 1036.160709825044, 1037.4345981440094, 1039.3763741754963, 1039.9480025998746, 1040.6461802986983, 719.6257945868172, 744.4342299852151, 748.6294284329238, 755.7543798265531, 756.5309508104955, 19046.61906761857, 19434.416967490997, 19533.609327813363, 19636.80363196364, 19724.0, 21023.369298921058, 21100.788992110036, 21535.461613459633, 21586.676199857015, 21662.133514659396, 17275.654486910193, 17577.0, 17601.94388336704, 17639.294428222856, 17712.645747084985, 3802.049487628093, 3816.751911125768, 3826.770393776382, 3831.616838316146, 3833.750806197616, 108051.61832030487, 143791.0, 149445.25277373652, 149732.0, 150527.0, 16819.91590042042, 17091.914540427468, 17246.137693115295, 17250.741238881426, 17323.56691082733, 31798.523022154684, 32405.18987025296, 32446.351072978407, 32645.836770815993, 32652.346953060805, 8751.737447876574, 9124.58939347731, 9144.954275228582, 9154.954225228965, 9335.953320233355, 4269.935950960738, 4321.330193819963, 4333.263345231255, 4334.9783251083545, 4341.717788343748, 5499.257600223918, 5586.776528938878, 5590.105583106765, 5641.266635337462, 5672.574556908248, 1078.6116997880756, 1083.1605505732962, 1099.769048499808, 1101.3171833463305, 1109.6005438042298, 688.6178171114979, 701.347746595671, 708.4190963409955, 711.647734371479, 713.3900515059653, 11956.58151964677, 12849.293288869201, 13054.673633159056, 13209.669758255928, 13535.661608459868, 706.6925887239067, 710.8791505444087, 719.9676014579356, 730.1603156370217, 736.120336198238, 5917.52659787216, 5941.673207973517, 5978.671173085435, 6007.879842403127, 6106.45041946227, 118229.40885295518, 120731.0, 121806.0, 122537.0, 123989.0, 86163.13836861552, 100563.0, 105473.47263263635, 113055.43472282586, 115417.99999999833, 91287.99999999868, 92337.0, 93171.53414233022, 94271.52864235635, 95470.52264738631, 12942.352882356034, 13188.934055330046, 13195.67010824737, 13210.0, 13338.866611333762, 40104.0, 41025.56410525617, 41043.7947810271, 42485.362719558616, 43356.132877342905, 54960.450395495536, 55353.44646553483, 55961.44038559725, 56348.0, 56521.15218271647, 18344.541386464913, 18477.16852741657, 18489.81510184881, 18529.44411667652, 18991.33530326432, 20004.799952000874, 20775.168993240102, 20789.584208316053, 20938.0, 21234.681479777508, 17483.56291092733, 18298.176582053573, 18585.53536161607, 18676.719849202, 18688.0, 17388.43537074922, 17525.386611468537, 17707.557311067325, 17847.821521785136, 17898.194581244137, 17634.647307054045, 17937.0, 17993.640127197643, 18037.368692095715, 18193.81806181974, 13347.599572012856, 13475.3936072875, 13480.93259533696, 13581.932090339486, 14077.718445630826, 14095.154290742588, 14217.786733199217, 14264.714705706036, 14324.212168330841, 14389.568312950629], "value": 9342.498548666472, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 109.0, 116.0, 113.0, 108.0, 115.0, 118.0, 109.0, 118.0, 107.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 121.0, 117.0, 123.0, 115.0, 149.0, 124.0, 126.0, 122.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 164.0, 168.0, 163.0, 169.0, 171.0, 165.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 81.0, 80.0, 79.0, 76.0, 74.0, 75.0, 78.0, 93.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 84.0, 85.0, 79.0, 84.0, 87.0, 86.0, 86.0, 81.0, 79.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 115.0, 113.0, 120.0, 116.0, 114.0, 114.0, 118.0, 118.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 152.0, 148.0, 149.0, 150.0, 149.0, 149.0, 159.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 98.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 54.0, 57.0, 57.0, 54.0, 57.0, 56.0, 55.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 45.0, 40.0, 49.0, 45.0, 46.0, 38.0, 48.0, 45.0], "value": 44.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 77.0, 85.0, 81.0, 79.0, 85.0, 75.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 111.0, 112.0, 115.0, 111.0, 113.0, 116.0, 110.0, 119.0], "value": 114.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 165.0, 167.0, 172.0, 179.0, 168.0, 169.0, 178.0, 166.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 64.0, 67.0, 66.0, 71.0, 69.0, 78.0, 64.0, 62.0], "value": 69.4, "unit": "score"}]}]} 03:07:14 INFO - Return code: 0 03:07:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:07:14 INFO - # TBPL SUCCESS # 03:07:14 INFO - Running post-action listener: _package_coverage_data 03:07:14 INFO - Running post-action listener: _resource_record_post_action 03:07:14 INFO - [mozharness: 2017-09-16 10:07:14.950359Z] Finished run-tests step (success) 03:07:14 INFO - Running post-run listener: _resource_record_post_run 03:07:15 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 337657856; Read time: 0; Write time: 196680 03:07:15 INFO - TinderboxPrint: CPU usage
13.3% 03:07:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:07:15 INFO - TinderboxPrint: I/O write bytes / time
337,657,856 / 196,680 03:07:15 INFO - TinderboxPrint: CPU idle
8,258.2 (86.7%) 03:07:15 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 03:07:15 INFO - TinderboxPrint: Swap in / out
0 / 0 03:07:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12312576; Read time: 0; Write time: 1684 03:07:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:07:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 323903488; Read time: 0; Write time: 194948 03:07:15 INFO - Running post-run listener: _upload_blobber_files 03:07:15 INFO - Blob upload gear active. 03:07:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:07:15 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 03:07:15 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'] 03:07:15 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 03:07:15 INFO - (blobuploader) - INFO - Open directory for files ... 03:07:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:07:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:07:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:19 INFO - (blobuploader) - INFO - Done attempting. 03:07:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:07:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:07:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:20 INFO - (blobuploader) - INFO - Done attempting. 03:07:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:07:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:07:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:22 INFO - (blobuploader) - INFO - Done attempting. 03:07:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:07:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:23 INFO - (blobuploader) - INFO - Done attempting. 03:07:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:23 INFO - Return code: 0 03:07:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:07:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107205e0c5a3505a97e7bf9963e20083218f492190e2bb5c3014f1f9fe9e410b5658a507a18f544dea8ce9c3ce41039f8961acca6bec6c1e37138a4c8d5216e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f1a38dfab44d9e1f669b5ab28a11a9f30e73ddd688e20eccf5b537d7b25367c5bbc17e1758a7d4b5d44891ea1592d319e56de98a965a7b0c5e7be620ffcdd7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d4e1da1c9861be6cdaf4910b6ecc79fb93e6b218686d38cda5d4bdec77d7fd27df7c43dd9c74b135ebb98e68c65ed7b913991cd1471d3db4d2c52116ddcfb7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b11ea0756f94c3b126e95488e4dc246969be5170571c6062091537affddceb59bbb2edba162a08f0b8506a449095fba23669137a558f36e6503de50fedf6e60"} 03:07:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:07:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:07:23 INFO - Contents: 03:07:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107205e0c5a3505a97e7bf9963e20083218f492190e2bb5c3014f1f9fe9e410b5658a507a18f544dea8ce9c3ce41039f8961acca6bec6c1e37138a4c8d5216e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f1a38dfab44d9e1f669b5ab28a11a9f30e73ddd688e20eccf5b537d7b25367c5bbc17e1758a7d4b5d44891ea1592d319e56de98a965a7b0c5e7be620ffcdd7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d4e1da1c9861be6cdaf4910b6ecc79fb93e6b218686d38cda5d4bdec77d7fd27df7c43dd9c74b135ebb98e68c65ed7b913991cd1471d3db4d2c52116ddcfb7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b11ea0756f94c3b126e95488e4dc246969be5170571c6062091537affddceb59bbb2edba162a08f0b8506a449095fba23669137a558f36e6503de50fedf6e60"} 03:07:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:23 INFO - Copying logs to upload dir... 03:07:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:07:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.960915 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-16 03:07:23.377876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:07:23.382423) ========= 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=dac658600622fd96716c9acf000001b3-1505546407.535171-7488871 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/107205e0c5a3505a97e7bf9963e20083218f492190e2bb5c3014f1f9fe9e410b5658a507a18f544dea8ce9c3ce41039f8961acca6bec6c1e37138a4c8d5216e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f1a38dfab44d9e1f669b5ab28a11a9f30e73ddd688e20eccf5b537d7b25367c5bbc17e1758a7d4b5d44891ea1592d319e56de98a965a7b0c5e7be620ffcdd7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d4e1da1c9861be6cdaf4910b6ecc79fb93e6b218686d38cda5d4bdec77d7fd27df7c43dd9c74b135ebb98e68c65ed7b913991cd1471d3db4d2c52116ddcfb7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b11ea0756f94c3b126e95488e4dc246969be5170571c6062091537affddceb59bbb2edba162a08f0b8506a449095fba23669137a558f36e6503de50fedf6e60"} build_url:https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/V7UvXOTwSFSG24DAmofqJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107205e0c5a3505a97e7bf9963e20083218f492190e2bb5c3014f1f9fe9e410b5658a507a18f544dea8ce9c3ce41039f8961acca6bec6c1e37138a4c8d5216e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9f1a38dfab44d9e1f669b5ab28a11a9f30e73ddd688e20eccf5b537d7b25367c5bbc17e1758a7d4b5d44891ea1592d319e56de98a965a7b0c5e7be620ffcdd7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2d4e1da1c9861be6cdaf4910b6ecc79fb93e6b218686d38cda5d4bdec77d7fd27df7c43dd9c74b135ebb98e68c65ed7b913991cd1471d3db4d2c52116ddcfb7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b11ea0756f94c3b126e95488e4dc246969be5170571c6062091537affddceb59bbb2edba162a08f0b8506a449095fba23669137a558f36e6503de50fedf6e60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:07:23.412442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:07:23.412881) ========= 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=dac658600622fd96716c9acf000001b3-1505546407.535171-7488871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:07:23.468748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:07:23.469068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:07:23.469379) ========= ========= Total master_lag: 0.28 =========