builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1505170042.81 results: success (0) revision: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.813581) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.814038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.814317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.914823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:22.915148) ========= 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=0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 15:47:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-09-11 15:47:23 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.301454 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.269882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.270159) ========= 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=0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014381 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:23.321011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-11 15:47:23.321312) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d --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 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d --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=0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 15:47:23,551 truncating revision to first 12 chars 2017-09-11 15:47:23,551 Setting DEBUG logging. 2017-09-11 15:47:23,551 attempt 1/10 2017-09-11 15:47:23,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a6d2e30bbe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 15:47:24,453 unpacking tar archive at: mozilla-central-3a6d2e30bbe1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-11 15:47:24.534669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:24.534982) ========= script_repo_revision: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:24.535382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:24.535737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 15:47:24.548800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-09-11 15:47:24.549135) ========= /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=0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:25 INFO - MultiFileLogger online at 20170911 15:47:25 in /builds/slave/test 15:47:25 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 15:47:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:25 INFO - {'append_to_log': False, 15:47:25 INFO - 'base_work_dir': '/builds/slave/test', 15:47:25 INFO - 'blob_upload_branch': 'Firefox', 15:47:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:25 INFO - 'branch': 'Firefox', 15:47:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:25 INFO - 'code_coverage': False, 15:47:25 INFO - 'config_files': ('talos/linux_config.py',), 15:47:25 INFO - 'default_actions': ('clobber', 15:47:25 INFO - 'read-buildbot-config', 15:47:25 INFO - 'download-and-extract', 15:47:25 INFO - 'populate-webroot', 15:47:25 INFO - 'create-virtualenv', 15:47:25 INFO - 'install', 15:47:25 INFO - 'setup-mitmproxy', 15:47:25 INFO - 'run-tests'), 15:47:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:25 INFO - 'disable_ccov_upload': False, 15:47:25 INFO - 'disable_stylo': False, 15:47:25 INFO - 'download_minidump_stackwalk': True, 15:47:25 INFO - 'download_symbols': 'ondemand', 15:47:25 INFO - 'enable_stylo': False, 15:47:25 INFO - 'enable_webrender': False, 15:47:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:47:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:25 INFO - 'gecko_profile': False, 15:47:25 INFO - 'gecko_profile_interval': 0, 15:47:25 INFO - 'installer_path': 'installer.exe', 15:47:25 INFO - 'log_level': 'info', 15:47:25 INFO - 'log_name': 'talos', 15:47:25 INFO - 'log_to_console': True, 15:47:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:25 INFO - 'opt_config_files': (), 15:47:25 INFO - 'pip_index': False, 15:47:25 INFO - 'suite': 'dromaeojs-e10s', 15:47:25 INFO - 'system_bits': '32', 15:47:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:25 INFO - 'title': 'talos-linux64-ix-058', 15:47:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:25 INFO - 'use_talos_json': True, 15:47:25 INFO - 'verify': 'False', 15:47:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:25 INFO - 'work_dir': 'build'} 15:47:25 INFO - [mozharness: 2017-09-11 22:47:25.026476Z] Running clobber step. 15:47:25 INFO - Running pre-action listener: _resource_record_pre_action 15:47:25 INFO - Running main action method: clobber 15:47:25 INFO - rmtree: /builds/slave/test/build 15:47:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:26 INFO - Running post-action listener: _resource_record_post_action 15:47:26 INFO - [mozharness: 2017-09-11 22:47:26.000843Z] Finished clobber step (success) 15:47:26 INFO - [mozharness: 2017-09-11 22:47:26.000956Z] Running read-buildbot-config step. 15:47:26 INFO - Running pre-action listener: _resource_record_pre_action 15:47:26 INFO - Running main action method: read_buildbot_config 15:47:26 INFO - Using buildbot properties: 15:47:26 INFO - { 15:47:26 INFO - "project": "", 15:47:26 INFO - "product": "firefox", 15:47:26 INFO - "who": "archaeopteryx@coole-files.de", 15:47:26 INFO - "installer_path": "public/build/target.tar.bz2", 15:47:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:47:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:47:26 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:47:26 INFO - "stage_platform": "linux64-qr", 15:47:26 INFO - "basedir": "/builds/slave/test", 15:47:26 INFO - "buildnumber": 48, 15:47:26 INFO - "platform": "ubuntu64_hw_qr", 15:47:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:47:26 INFO - "slavebuilddir": "test", 15:47:26 INFO - "taskId": "YQRx9KIhRRywoR-mggT6fg", 15:47:26 INFO - "branch": "mozilla-central", 15:47:26 INFO - "script_repo_revision": "production", 15:47:26 INFO - "revision": "3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d", 15:47:26 INFO - "slavename": "talos-linux64-ix-058", 15:47:26 INFO - "repo_path": "mozilla-central" 15:47:26 INFO - } 15:47:26 INFO - Finding installer, test and symbols from parent task. 15:47:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQRx9KIhRRywoR-mggT6fg'}, attempt #1 15:47:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQRx9KIhRRywoR-mggT6fg'}, attempt #1 15:47:26 INFO - Task dependencies: NZL3uDQ6TNSAakTme7WydQ 15:47:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ'}, attempt #1 15:47:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json 15:47:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip 15:47:27 INFO - Running post-action listener: _resource_record_post_action 15:47:27 INFO - [mozharness: 2017-09-11 22:47:27.395765Z] Finished read-buildbot-config step (success) 15:47:27 INFO - [mozharness: 2017-09-11 22:47:27.395982Z] Running download-and-extract step. 15:47:27 INFO - Running pre-action listener: _resource_record_pre_action 15:47:27 INFO - Running main action method: download_and_extract 15:47:27 INFO - mkdir: /builds/slave/test/build/tests 15:47:27 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')]} 15:47:27 INFO - trying https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json 15:47:27 INFO - Downloading https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:47:27 INFO - Downloaded 989 bytes. 15:47:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:47:27 INFO - Using the following test package requirements: 15:47:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:47:27 INFO - u'common': [u'target.common.tests.zip'], 15:47:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:47:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:47:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:47:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:47:27 INFO - u'mozbase': [u'target.common.tests.zip'], 15:47:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:47:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:47:27 INFO - u'web-platform': [u'target.common.tests.zip', 15:47:27 INFO - u'target.web-platform.tests.tar.gz'], 15:47:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:47:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.common.tests.zip 15:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.common.tests.zip into memory 15:47:29 INFO - Content-Length response header: 55028403 15:47:29 INFO - Bytes received: 55028403 15:47:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.talos.tests.zip 15:47:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:47:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.talos.tests.zip into memory 15:47:42 INFO - Content-Length response header: 14497963 15:47:42 INFO - Bytes received: 14497963 15:47:42 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')]} 15:47:42 INFO - trying https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:42 INFO - Downloading https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:47:43 INFO - Downloaded 62919275 bytes. 15:47:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:43 INFO - mkdir: /builds/slave/test/properties 15:47:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:43 INFO - Contents: 15:47:43 INFO - build_url:https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 15:47:43 INFO - Running post-action listener: _resource_record_post_action 15:47:43 INFO - Running post-action listener: find_tests_for_verification 15:47:43 INFO - Running post-action listener: set_extra_try_arguments 15:47:43 INFO - [mozharness: 2017-09-11 22:47:43.715018Z] Finished download-and-extract step (success) 15:47:43 INFO - [mozharness: 2017-09-11 22:47:43.715114Z] Running populate-webroot step. 15:47:43 INFO - Running pre-action listener: _resource_record_pre_action 15:47:43 INFO - Running main action method: populate_webroot 15:47:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['tresize', 15:47:43 INFO - 'tcanvasmark']}, 15:47:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['dromaeo_css', 15:47:43 INFO - 'kraken']}, 15:47:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'tests': ['damp', 'tps']}, 15:47:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['damp', 'tps']}, 15:47:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['dromaeo_dom']}, 15:47:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:47:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['basic_compositor_video', 15:47:43 INFO - 'glvideo']}, 15:47:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:47:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['ts_paint_webext', 15:47:43 INFO - 'tp5o_webext']}, 15:47:43 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_many_windows', 15:47:43 INFO - 'sessionrestore_no_auto_restore', 15:47:43 INFO - 'tabpaint']}, 15:47:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_many_windows', 15:47:43 INFO - 'sessionrestore_no_auto_restore', 15:47:43 INFO - 'tabpaint']}, 15:47:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:47:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:47:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['bloom_basic_singleton']}, 15:47:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['bloom_basic']}, 15:47:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:43 INFO - 'tsvgr_opacity', 15:47:43 INFO - 'tart', 15:47:43 INFO - 'tscrollx', 15:47:43 INFO - 'tsvg_static']}, 15:47:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['tsvgx', 15:47:43 INFO - 'tsvgr_opacity', 15:47:43 INFO - 'tart', 15:47:43 INFO - 'tscrollx', 15:47:43 INFO - 'tsvg_static']}, 15:47:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:47:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'talos_options': ['--disable-stylo'], 15:47:43 INFO - 'tests': ['tp5o']}, 15:47:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:43 INFO - 'talos_options': ['--mitmproxy', 15:47:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:43 INFO - '--firstNonBlankPaint'], 15:47:43 INFO - 'tests': ['tp6_google', 15:47:43 INFO - 'tp6_youtube', 15:47:43 INFO - 'tp6_amazon', 15:47:43 INFO - 'tp6_facebook']}, 15:47:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:43 INFO - 'talos_options': ['--disable-stylo', 15:47:43 INFO - '--mitmproxy', 15:47:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:43 INFO - '--firstNonBlankPaint'], 15:47:43 INFO - 'tests': ['tp6_google', 15:47:43 INFO - 'tp6_youtube', 15:47:43 INFO - 'tp6_amazon', 15:47:43 INFO - 'tp6_facebook']}, 15:47:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:43 INFO - 'talos_options': ['--stylo-threads=1', 15:47:43 INFO - '--mitmproxy', 15:47:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:43 INFO - '--firstNonBlankPaint'], 15:47:43 INFO - 'tests': ['tp6_google', 15:47:43 INFO - 'tp6_youtube', 15:47:43 INFO - 'tp6_amazon', 15:47:43 INFO - 'tp6_facebook']}, 15:47:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'talos_options': ['--xperf_path', 15:47:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:43 INFO - 'tests': ['tp5n']}, 15:47:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:47:43 INFO - 'talos_options': ['--disable-stylo', 15:47:43 INFO - '--xperf_path', 15:47:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:43 INFO - 'tests': ['tp5n']}}} 15:47:43 INFO - Running post-action listener: _resource_record_post_action 15:47:43 INFO - [mozharness: 2017-09-11 22:47:43.730143Z] Finished populate-webroot step (success) 15:47:43 INFO - [mozharness: 2017-09-11 22:47:43.730232Z] Running create-virtualenv step. 15:47:43 INFO - Running pre-action listener: _resource_record_pre_action 15:47:43 INFO - Running main action method: create_virtualenv 15:47:43 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:47:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:47:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:47:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:46 INFO - Installing pip...............done. 15:47:46 INFO - Return code: 0 15:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:47:46 INFO - Reading from file tmpfile_stdout 15:47:46 INFO - Output received: 15:47:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:47:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47:46 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')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 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')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 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 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:46 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 15:47:46 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 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:47:47 INFO - Downloading/unpacking pip>=1.5 15:47:47 INFO - Running setup.py egg_info for package pip 15:47:47 INFO - warning: no files found matching 'pip/cacert.pem' 15:47:47 INFO - warning: no files found matching '*.html' under directory 'docs' 15:47:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:47:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:47:47 INFO - Installing collected packages: pip 15:47:47 INFO - Found existing installation: pip 1.1 15:47:47 INFO - Uninstalling pip: 15:47:47 INFO - Successfully uninstalled pip 15:47:47 INFO - Running setup.py install for pip 15:47:47 INFO - warning: no files found matching 'pip/cacert.pem' 15:47:47 INFO - warning: no files found matching '*.html' under directory 'docs' 15:47:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:47:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:47:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:47:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:47:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:47:47 INFO - Successfully installed pip 15:47:47 INFO - Cleaning up... 15:47:47 INFO - Return code: 0 15:47:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:47:47 INFO - Using env: {'DISPLAY': ':0', 15:47:47 INFO - 'HOME': '/home/cltbld', 15:47:47 INFO - 'LANG': 'en_US.UTF-8', 15:47:47 INFO - 'LANGUAGE': 'en_US:en', 15:47:47 INFO - 'LOGNAME': 'cltbld', 15:47:47 INFO - 'MAIL': '/var/mail/cltbld', 15:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:47 INFO - 'MOZ_NO_REMOTE': '1', 15:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:47 INFO - 'NO_EM_RESTART': '1', 15:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:47 INFO - 'PWD': '/builds/slave/test', 15:47:47 INFO - 'SHELL': '/bin/bash', 15:47:47 INFO - 'SHLVL': '1', 15:47:47 INFO - 'TERM': 'linux', 15:47:47 INFO - 'TMOUT': '86400', 15:47:47 INFO - 'USER': 'cltbld', 15:47:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:47 INFO - '_': '/tools/buildbot/bin/python'} 15:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:47 INFO - Downloading/unpacking psutil>=3.1.1 15:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:49 INFO - Installing collected packages: psutil 15:47:49 INFO - Running setup.py install for psutil 15:47:49 INFO - building 'psutil._psutil_linux' extension 15:47:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:47:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:47:50 INFO - building 'psutil._psutil_posix' extension 15:47:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:47:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:47:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:51 INFO - Successfully installed psutil 15:47:51 INFO - Cleaning up... 15:47:51 INFO - Return code: 0 15:47:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47:51 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')]} 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:51 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')]} 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:51 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 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:51 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 15:47:51 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 15:47:51 INFO - Using env: {'DISPLAY': ':0', 15:47:51 INFO - 'HOME': '/home/cltbld', 15:47:51 INFO - 'LANG': 'en_US.UTF-8', 15:47:51 INFO - 'LANGUAGE': 'en_US:en', 15:47:51 INFO - 'LOGNAME': 'cltbld', 15:47:51 INFO - 'MAIL': '/var/mail/cltbld', 15:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:51 INFO - 'MOZ_NO_REMOTE': '1', 15:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:51 INFO - 'NO_EM_RESTART': '1', 15:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:51 INFO - 'PWD': '/builds/slave/test', 15:47:51 INFO - 'SHELL': '/bin/bash', 15:47:51 INFO - 'SHLVL': '1', 15:47:51 INFO - 'TERM': 'linux', 15:47:51 INFO - 'TMOUT': '86400', 15:47:51 INFO - 'USER': 'cltbld', 15:47:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:51 INFO - '_': '/tools/buildbot/bin/python'} 15:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47:51 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 15:47:51 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 15:47:51 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 15:47:51 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 15:47:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:52 INFO - Installing collected packages: mozsystemmonitor 15:47:52 INFO - Running setup.py install for mozsystemmonitor 15:47:52 INFO - Successfully installed mozsystemmonitor 15:47:52 INFO - Cleaning up... 15:47:52 INFO - Return code: 0 15:47:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:47:52 INFO - Using env: {'DISPLAY': ':0', 15:47:52 INFO - 'HOME': '/home/cltbld', 15:47:52 INFO - 'LANG': 'en_US.UTF-8', 15:47:52 INFO - 'LANGUAGE': 'en_US:en', 15:47:52 INFO - 'LOGNAME': 'cltbld', 15:47:52 INFO - 'MAIL': '/var/mail/cltbld', 15:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:52 INFO - 'MOZ_NO_REMOTE': '1', 15:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:52 INFO - 'NO_EM_RESTART': '1', 15:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:52 INFO - 'PWD': '/builds/slave/test', 15:47:52 INFO - 'SHELL': '/bin/bash', 15:47:52 INFO - 'SHLVL': '1', 15:47:52 INFO - 'TERM': 'linux', 15:47:52 INFO - 'TMOUT': '86400', 15:47:52 INFO - 'USER': 'cltbld', 15:47:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:52 INFO - '_': '/tools/buildbot/bin/python'} 15:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:53 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:54 INFO - warning: no files found matching '*.txt' 15:47:54 INFO - no previously-included directories found matching 'build' 15:47:54 INFO - no previously-included directories found matching 'dist' 15:47:54 INFO - no previously-included directories found matching '.git*' 15:47:54 INFO - Installing collected packages: jsonschema, functools32 15:47:54 INFO - Running setup.py install for functools32 15:47:54 INFO - warning: no files found matching '*.txt' 15:47:54 INFO - no previously-included directories found matching 'build' 15:47:54 INFO - no previously-included directories found matching 'dist' 15:47:54 INFO - no previously-included directories found matching '.git*' 15:47:54 INFO - Successfully installed jsonschema functools32 15:47:54 INFO - Cleaning up... 15:47:54 INFO - Return code: 0 15:47:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:47:54 INFO - Using env: {'DISPLAY': ':0', 15:47:54 INFO - 'HOME': '/home/cltbld', 15:47:54 INFO - 'LANG': 'en_US.UTF-8', 15:47:54 INFO - 'LANGUAGE': 'en_US:en', 15:47:54 INFO - 'LOGNAME': 'cltbld', 15:47:54 INFO - 'MAIL': '/var/mail/cltbld', 15:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:54 INFO - 'MOZ_NO_REMOTE': '1', 15:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:54 INFO - 'NO_EM_RESTART': '1', 15:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:54 INFO - 'PWD': '/builds/slave/test', 15:47:54 INFO - 'SHELL': '/bin/bash', 15:47:54 INFO - 'SHLVL': '1', 15:47:54 INFO - 'TERM': 'linux', 15:47:54 INFO - 'TMOUT': '86400', 15:47:54 INFO - 'USER': 'cltbld', 15:47:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:54 INFO - '_': '/tools/buildbot/bin/python'} 15:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:47:54 INFO - Cleaning up... 15:47:54 INFO - Return code: 0 15:47:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:47:54 INFO - Using env: {'DISPLAY': ':0', 15:47:54 INFO - 'HOME': '/home/cltbld', 15:47:54 INFO - 'LANG': 'en_US.UTF-8', 15:47:54 INFO - 'LANGUAGE': 'en_US:en', 15:47:54 INFO - 'LOGNAME': 'cltbld', 15:47:54 INFO - 'MAIL': '/var/mail/cltbld', 15:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:54 INFO - 'MOZ_NO_REMOTE': '1', 15:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:54 INFO - 'NO_EM_RESTART': '1', 15:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:54 INFO - 'PWD': '/builds/slave/test', 15:47:54 INFO - 'SHELL': '/bin/bash', 15:47:54 INFO - 'SHLVL': '1', 15:47:54 INFO - 'TERM': 'linux', 15:47:54 INFO - 'TMOUT': '86400', 15:47:54 INFO - 'USER': 'cltbld', 15:47:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:54 INFO - '_': '/tools/buildbot/bin/python'} 15:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - Downloading docopt-0.6.1.tar.gz 15:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:56 INFO - Running setup.py install for blobuploader 15:47:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:56 INFO - Running setup.py install for requests 15:47:57 INFO - Running setup.py install for docopt 15:47:57 INFO - Successfully installed blobuploader requests docopt 15:47:57 INFO - Cleaning up... 15:47:57 INFO - Return code: 0 15:47:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47: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')]} 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:57 INFO - Using env: {'DISPLAY': ':0', 15:47:57 INFO - 'HOME': '/home/cltbld', 15:47:57 INFO - 'LANG': 'en_US.UTF-8', 15:47:57 INFO - 'LANGUAGE': 'en_US:en', 15:47:57 INFO - 'LOGNAME': 'cltbld', 15:47:57 INFO - 'MAIL': '/var/mail/cltbld', 15:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:57 INFO - 'MOZ_NO_REMOTE': '1', 15:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:57 INFO - 'NO_EM_RESTART': '1', 15:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:57 INFO - 'PWD': '/builds/slave/test', 15:47:57 INFO - 'SHELL': '/bin/bash', 15:47:57 INFO - 'SHLVL': '1', 15:47:57 INFO - 'TERM': 'linux', 15:47:57 INFO - 'TMOUT': '86400', 15:47:57 INFO - 'USER': 'cltbld', 15:47:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:57 INFO - '_': '/tools/buildbot/bin/python'} 15:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:57 INFO - Running setup.py (path:/tmp/pip-DLVW7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:57 INFO - Running setup.py (path:/tmp/pip-Nl0asy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:57 INFO - Running setup.py (path:/tmp/pip-1qjZF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:57 INFO - Running setup.py (path:/tmp/pip-Z1H07o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:57 INFO - Running setup.py (path:/tmp/pip-d6h9Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:57 INFO - Running setup.py (path:/tmp/pip-J1aeqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:58 INFO - Running setup.py (path:/tmp/pip-SWtDID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:58 INFO - Running setup.py (path:/tmp/pip-zrGWyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:58 INFO - Running setup.py (path:/tmp/pip-VRJprA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:58 INFO - Running setup.py (path:/tmp/pip-nhRFUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:58 INFO - Running setup.py (path:/tmp/pip-gT7Xfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:58 INFO - Running setup.py (path:/tmp/pip-_Ug9Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:58 INFO - Running setup.py (path:/tmp/pip-i3_HZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:58 INFO - Running setup.py (path:/tmp/pip-Cc4BAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:58 INFO - Running setup.py (path:/tmp/pip-KE5dkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:58 INFO - Running setup.py (path:/tmp/pip-TYie9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:58 INFO - Running setup.py (path:/tmp/pip-rhrZI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:58 INFO - Running setup.py install for manifestparser 15:47:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:47:58 INFO - Running setup.py install for mozcrash 15:47:59 INFO - Running setup.py install for mozdebug 15:47:59 INFO - Running setup.py install for mozdevice 15:47:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Running setup.py install for mozfile 15:47:59 INFO - Running setup.py install for mozhttpd 15:47:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Running setup.py install for mozinfo 15:47:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Running setup.py install for mozInstall 15:47:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Running setup.py install for mozleak 15:47:59 INFO - Running setup.py install for mozlog 15:47:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Running setup.py install for moznetwork 15:47:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:47:59 INFO - Running setup.py install for mozprocess 15:48:00 INFO - Running setup.py install for mozprofile 15:48:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:00 INFO - Running setup.py install for mozrunner 15:48:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:00 INFO - Running setup.py install for mozscreenshot 15:48:00 INFO - Running setup.py install for moztest 15:48:00 INFO - Running setup.py install for mozversion 15:48:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:00 INFO - Cleaning up... 15:48:00 INFO - Return code: 0 15:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48: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')]} 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:00 INFO - Using env: {'DISPLAY': ':0', 15:48:00 INFO - 'HOME': '/home/cltbld', 15:48:00 INFO - 'LANG': 'en_US.UTF-8', 15:48:00 INFO - 'LANGUAGE': 'en_US:en', 15:48:00 INFO - 'LOGNAME': 'cltbld', 15:48:00 INFO - 'MAIL': '/var/mail/cltbld', 15:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:00 INFO - 'MOZ_NO_REMOTE': '1', 15:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:00 INFO - 'NO_EM_RESTART': '1', 15:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:00 INFO - 'PWD': '/builds/slave/test', 15:48:00 INFO - 'SHELL': '/bin/bash', 15:48:00 INFO - 'SHLVL': '1', 15:48:00 INFO - 'TERM': 'linux', 15:48:00 INFO - 'TMOUT': '86400', 15:48:00 INFO - 'USER': 'cltbld', 15:48:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:00 INFO - '_': '/tools/buildbot/bin/python'} 15:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:00 INFO - Running setup.py (path:/tmp/pip-f0l041-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:00 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)) 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:00 INFO - Running setup.py (path:/tmp/pip-szBL9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:00 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)) 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:00 INFO - Running setup.py (path:/tmp/pip-PTDfWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:01 INFO - Running setup.py (path:/tmp/pip-pKjqZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:01 INFO - Running setup.py (path:/tmp/pip-1D9wPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:01 INFO - Running setup.py (path:/tmp/pip-cLwJw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:01 INFO - Running setup.py (path:/tmp/pip-kUmJki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:01 INFO - Running setup.py (path:/tmp/pip-jKZ3DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:01 INFO - Running setup.py (path:/tmp/pip-bi_NE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:01 INFO - Running setup.py (path:/tmp/pip-FQ0JWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:01 INFO - Running setup.py (path:/tmp/pip-ZCMPsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:01 INFO - Running setup.py (path:/tmp/pip-9hoR_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:01 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)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:01 INFO - Running setup.py (path:/tmp/pip-YOEpym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:01 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)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:01 INFO - Running setup.py (path:/tmp/pip-sFNoqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:01 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)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:01 INFO - Running setup.py (path:/tmp/pip-GKcIqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:01 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)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:01 INFO - Running setup.py (path:/tmp/pip-NWLk5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:01 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)) 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:01 INFO - Running setup.py (path:/tmp/pip-3aQyVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:04 INFO - Downloading blessings-1.6.tar.gz 15:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:04 INFO - Installing collected packages: blessings 15:48:04 INFO - Running setup.py install for blessings 15:48:04 INFO - Successfully installed blessings 15:48:04 INFO - Cleaning up... 15:48:04 INFO - Return code: 0 15:48:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:04 INFO - Reading from file tmpfile_stdout 15:48:04 INFO - Current package versions: 15:48:04 INFO - argparse == 1.2.1 15:48:04 INFO - blessings == 1.6 15:48:04 INFO - blobuploader == 1.2.4 15:48:04 INFO - docopt == 0.6.1 15:48:04 INFO - functools32 == 3.2.3-2 15:48:04 INFO - jsonschema == 2.5.1 15:48:04 INFO - manifestparser == 1.1 15:48:04 INFO - mozInstall == 1.13 15:48:04 INFO - mozcrash == 1.0 15:48:04 INFO - mozdebug == 0.1 15:48:04 INFO - mozdevice == 0.51 15:48:04 INFO - mozfile == 1.2 15:48:04 INFO - mozhttpd == 0.7 15:48:04 INFO - mozinfo == 0.10 15:48:04 INFO - mozleak == 0.1 15:48:04 INFO - mozlog == 3.5 15:48:04 INFO - moznetwork == 0.27 15:48:04 INFO - mozprocess == 0.25 15:48:04 INFO - mozprofile == 0.28 15:48:04 INFO - mozrunner == 6.13 15:48:04 INFO - mozscreenshot == 0.1 15:48:04 INFO - mozsystemmonitor == 0.3 15:48:04 INFO - moztest == 0.8 15:48:04 INFO - mozversion == 1.4 15:48:04 INFO - psutil == 3.1.1 15:48:04 INFO - requests == 1.2.3 15:48:04 INFO - wsgiref == 0.1.2 15:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:04 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')]} 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:04 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')]} 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:04 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 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:48:04 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 15:48:04 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 15:48:04 INFO - Using env: {'DISPLAY': ':0', 15:48:04 INFO - 'HOME': '/home/cltbld', 15:48:04 INFO - 'LANG': 'en_US.UTF-8', 15:48:04 INFO - 'LANGUAGE': 'en_US:en', 15:48:04 INFO - 'LOGNAME': 'cltbld', 15:48:04 INFO - 'MAIL': '/var/mail/cltbld', 15:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:04 INFO - 'MOZ_NO_REMOTE': '1', 15:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:04 INFO - 'NO_EM_RESTART': '1', 15:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:04 INFO - 'PWD': '/builds/slave/test', 15:48:04 INFO - 'SHELL': '/bin/bash', 15:48:04 INFO - 'SHLVL': '1', 15:48:04 INFO - 'TERM': 'linux', 15:48:04 INFO - 'TMOUT': '86400', 15:48:04 INFO - 'USER': 'cltbld', 15:48:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:04 INFO - '_': '/tools/buildbot/bin/python'} 15:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:48:06 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)) 15:48:06 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)) 15:48:06 INFO - Installing collected packages: simplejson 15:48:06 INFO - Running setup.py install for simplejson 15:48:06 INFO - building 'simplejson._speedups' extension 15:48:06 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 15:48:07 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 15:48:07 INFO - Successfully installed simplejson 15:48:07 INFO - Cleaning up... 15:48:07 INFO - Return code: 0 15:48:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:07 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')]} 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:07 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')]} 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:07 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 0x1fb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2180a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2323a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, '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': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', '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 15:48:07 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 15:48:07 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 15:48:07 INFO - Using env: {'DISPLAY': ':0', 15:48:07 INFO - 'HOME': '/home/cltbld', 15:48:07 INFO - 'LANG': 'en_US.UTF-8', 15:48:07 INFO - 'LANGUAGE': 'en_US:en', 15:48:07 INFO - 'LOGNAME': 'cltbld', 15:48:07 INFO - 'MAIL': '/var/mail/cltbld', 15:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:07 INFO - 'MOZ_NO_REMOTE': '1', 15:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:07 INFO - 'NO_EM_RESTART': '1', 15:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:07 INFO - 'PWD': '/builds/slave/test', 15:48:07 INFO - 'SHELL': '/bin/bash', 15:48:07 INFO - 'SHLVL': '1', 15:48:07 INFO - 'TERM': 'linux', 15:48:07 INFO - 'TMOUT': '86400', 15:48:07 INFO - 'USER': 'cltbld', 15:48:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:07 INFO - '_': '/tools/buildbot/bin/python'} 15:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:07 INFO - Cleaning up... 15:48:07 INFO - Return code: 0 15:48:07 INFO - Running post-action listener: _resource_record_post_action 15:48:07 INFO - Running post-action listener: _start_resource_monitoring 15:48:07 INFO - Starting resource monitoring. 15:48:07 INFO - [mozharness: 2017-09-11 22:48:07.417232Z] Finished create-virtualenv step (success) 15:48:07 INFO - [mozharness: 2017-09-11 22:48:07.418162Z] Running install step. 15:48:07 INFO - Running pre-action listener: _resource_record_pre_action 15:48:07 INFO - Running main action method: install 15:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:07 INFO - Reading from file tmpfile_stdout 15:48:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:07 INFO - Reading from file tmpfile_stdout 15:48:07 INFO - Output received: 15:48:07 INFO - Usage: mozinstall [options] installer 15:48:07 INFO - Options: 15:48:07 INFO - -h, --help show this help message and exit 15:48:07 INFO - -d DEST, --destination=DEST 15:48:07 INFO - Directory to install application into. [default: 15:48:07 INFO - "/builds/slave/test"] 15:48:07 INFO - --app=APP Application being installed. [default: firefox] 15:48:07 INFO - mkdir: /builds/slave/test/build/application 15:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:48:24 INFO - Reading from file tmpfile_stdout 15:48:24 INFO - Output received: 15:48:24 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:24 INFO - Running post-action listener: _resource_record_post_action 15:48:24 INFO - [mozharness: 2017-09-11 22:48:24.363062Z] Finished install step (success) 15:48:24 INFO - [mozharness: 2017-09-11 22:48:24.363313Z] Running setup-mitmproxy step. 15:48:24 INFO - Running pre-action listener: _resource_record_pre_action 15:48:24 INFO - Running main action method: setup_mitmproxy 15:48:24 INFO - Skipping: mitmproxy is not required 15:48:24 INFO - Running post-action listener: _resource_record_post_action 15:48:24 INFO - [mozharness: 2017-09-11 22:48:24.364448Z] Finished setup-mitmproxy step (success) 15:48:24 INFO - [mozharness: 2017-09-11 22:48:24.364672Z] Running run-tests step. 15:48:24 INFO - Running pre-action listener: _resource_record_pre_action 15:48:24 INFO - Running pre-action listener: _set_gcov_prefix 15:48:24 INFO - Running main action method: run_tests 15:48:24 WARNING - Try message not found. 15:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:24 INFO - Python 2.7.3 15:48:24 INFO - Return code: 0 15:48:24 INFO - grabbing minidump binary from tooltool 15:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2327090>, '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 0x2327d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2321f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:48:24 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:48:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:48:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:24 INFO - Return code: 0 15:48:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:24 INFO - ENV: RUST_BACKTRACE is now full 15:48:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:24 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/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 15:48:24 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/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 15:48:24 INFO - Using env: {'DISPLAY': ':0', 15:48:24 INFO - 'HOME': '/home/cltbld', 15:48:24 INFO - 'LANG': 'en_US.UTF-8', 15:48:24 INFO - 'LANGUAGE': 'en_US:en', 15:48:24 INFO - 'LOGNAME': 'cltbld', 15:48:24 INFO - 'MAIL': '/var/mail/cltbld', 15:48:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:24 INFO - 'MOZ_ACCELERATED': '1', 15:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:24 INFO - 'MOZ_NO_REMOTE': '1', 15:48:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:24 INFO - 'MOZ_WEBRENDER': '1', 15:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:24 INFO - 'NO_EM_RESTART': '1', 15:48:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:24 INFO - 'PWD': '/builds/slave/test', 15:48:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:24 INFO - 'RUST_BACKTRACE': 'full', 15:48:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:24 INFO - 'SHELL': '/bin/bash', 15:48:24 INFO - 'SHLVL': '1', 15:48:24 INFO - 'TERM': 'linux', 15:48:24 INFO - 'TMOUT': '86400', 15:48:24 INFO - 'USER': 'cltbld', 15:48:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:24 INFO - '_': '/tools/buildbot/bin/python'} 15:48:24 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/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 15:48:24 INFO - mozversion application_buildid: 20170911215847 15:48:24 INFO - mozversion application_changeset: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d 15:48:24 INFO - mozversion application_display_name: Nightly 15:48:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:24 INFO - mozversion application_name: Firefox 15:48:24 INFO - mozversion application_remotingname: firefox 15:48:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:24 INFO - mozversion application_vendor: Mozilla 15:48:24 INFO - mozversion application_version: 57.0a1 15:48:24 INFO - mozversion platform_buildid: 20170911215847 15:48:24 INFO - mozversion platform_changeset: 3a6d2e30bbe18b4ed6d3d964afe9c97237f0515d 15:48:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:24 INFO - mozversion platform_version: 57.0a1 15:48:24 INFO - using testdate: 1505170104 15:48:24 INFO - actual date: 1505170104 15:48:24 INFO - starting webserver on 'localhost:48620' 15:48:24 INFO - SUITE-START | Running 2 tests 15:48:24 INFO - TEST-START | dromaeo_css 15:48:24 INFO - Initialising browser for dromaeo_css test... 15:48:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48620/getInfo.html -profile /tmp/tmpjKWW2p/profile 15:48:24 INFO - TEST-INFO | started process 3528 (/builds/slave/test/build/application/firefox/firefox http://localhost:48620/getInfo.html) 15:48:35 INFO - TEST-INFO | 3528: exit 0 15:48:35 INFO - Browser initialized. 15:48:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:35 INFO - Using env: {'DISPLAY': ':0', 15:48:35 INFO - 'HOME': '/home/cltbld', 15:48:35 INFO - 'JSGC_DISABLE_POISONING': '1', 15:48:35 INFO - 'LANG': 'en_US.UTF-8', 15:48:35 INFO - 'LANGUAGE': 'en_US:en', 15:48:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:48:35 INFO - 'LOGNAME': 'cltbld', 15:48:35 INFO - 'MAIL': '/var/mail/cltbld', 15:48:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:35 INFO - 'MOZ_ACCELERATED': '1', 15:48:35 INFO - 'MOZ_CRASHREPORTER': '1', 15:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:48:35 INFO - 'MOZ_NO_REMOTE': '1', 15:48:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:35 INFO - 'MOZ_WEBRENDER': '1', 15:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:35 INFO - 'NO_EM_RESTART': '1', 15:48:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:35 INFO - 'PWD': '/builds/slave/test', 15:48:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:35 INFO - 'RUST_BACKTRACE': 'full', 15:48:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:35 INFO - 'SHELL': '/bin/bash', 15:48:35 INFO - 'SHLVL': '1', 15:48:35 INFO - 'TERM': 'linux', 15:48:35 INFO - 'TMOUT': '86400', 15:48:35 INFO - 'USER': 'cltbld', 15:48:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 15:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:35 INFO - '_': '/tools/buildbot/bin/python'} 15:48:35 INFO - TEST-INFO | started process 3737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKWW2p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:36 INFO - PID 3737 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:48:37 INFO - PID 3737 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:48:37 INFO - PID 3737 | 15:48:37 INFO - PID 3737 | (/builds/slave/test/build/application/firefox/firefox:3801): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:48:37 INFO - PID 3737 | 15:48:47 INFO - PID 3737 | RSS: Main: 219148288 15:48:47 INFO - PID 3737 | 15:51:44 INFO - PID 3737 | Cycle 1(1): loaded http://localhost:48620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48620/tests/dromaeo/cssquery-ext.html) 15:51:46 INFO - PID 3737 | RSS: Main: 229036032 15:51:46 INFO - PID 3737 | 15:54:48 INFO - PID 3737 | Cycle 1(1): loaded http://localhost:48620/tests/dromaeo/cssquery-ext.html (next: http://localhost:48620/tests/dromaeo/cssquery-jquery.html) 15:54:48 INFO - PID 3737 | RSS: Main: 225820672 15:54:48 INFO - PID 3737 | 15:57:50 INFO - PID 3737 | Cycle 1(1): loaded http://localhost:48620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48620/tests/dromaeo/cssquery-mootools.html) 15:57:51 INFO - PID 3737 | RSS: Main: 230756352 15:57:51 INFO - PID 3737 | 16:00:53 INFO - PID 3737 | Cycle 1(1): loaded http://localhost:48620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48620/tests/dromaeo/cssquery-prototype.html) 16:00:54 INFO - PID 3737 | RSS: Main: 226197504 16:00:54 INFO - PID 3737 | 16:03:57 INFO - PID 3737 | Cycle 1(1): loaded http://localhost:48620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48620/tests/dromaeo/cssquery-yui.html) 16:03:58 INFO - PID 3737 | RSS: Main: 228573184 16:03:58 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | Cycle 1(1): loaded http://localhost:48620/tests/dromaeo/cssquery-yui.html (next: http://localhost:48620/tests/dromaeo/cssquery-dojo.html) 16:07:00 INFO - PID 3737 | RSS: Main: 230354944 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | __start_tp_report 16:07:00 INFO - PID 3737 | _x_x_mozilla_page_load 16:07:00 INFO - PID 3737 | _x_x_mozilla_page_load_details 16:07:00 INFO - PID 3737 | |i|pagename|runs| 16:07:00 INFO - PID 3737 | |0;dojo.html;3024.319528106176;3115.1121930249883;3118.423091728032;3139.3250451153;3141.27750617358;6039.214902062726;6243.094751261065;6243.906341404882;6283.340249273829;6341.619502829822;6105.084237364386;6111.144439778434;6111.969440152804;6120;6129.295131059929;5587.972060139704;5613.775448982035;5645.633033852807;5666.121751128561;5720.313562372521;5694.088945768678;5725.656460612356;5759.68321742304;5828.883422331551;5888.7055647217685;5780.653160810344;5836.445537673914;5846.707664616773;5851.7074146292725;5852.67810270435;933.1800465468424;5794.768209271666;5843.2695913010875;5864.266966629171;5870.471657550841;5085.364329458817;5632.690202038886;5637.689927054011;5658.91511627326;5735.942640573582;6142.293636231846;6148.354422785588;6174.475169610543;6223.626582405071;6281.937180628181;6585.967070164666;6684.766033188864;6700.329967003309;6757.155355580552;6766.560173588701;6724.856774348373;6734.730610775563;6739.797806065826;6838.863222735517;6846.931530684679;6026.186464827279;6127.908081378783;6235.158253635746;6297.748090076391;6309.558330916838;6721.395074443323;6753.425958793558;6757.459403247728;6765.492588055916;6851.520393572402;6531.738730450824;6551.934480655133;6555.573887697285;6573.52095778446;6596.274409814917;6614.669266536654;6667.199936007613;6679.265280819106;6712.630805305755;6727.058211850345;6590.110335104795;6610.669466526654;6611.636360000246;6692.096566963398;6743.393094621508;6467.417932386108;6606.570572912745;6645.269020407752;6650.600963942179;6657.733690652417;5241.266222728821;5248.1340578804065;5262.2632831403635;5263.631545791758;5267.657602255841;4559.110973360163;4579.702319349231;4585.977070114628;4587.816487340469;4605.194091034055;5629.971850140805;5701.486866182064;5705.971470142623;5706.629069110494;5728.198052272685;6556.213254409501;6596.208454985433;6651.833704157435;6661.034150048215;6704.631245281556;5606.495415412551;5640.266765320482;5704.486596206361;5711.086226203787;5731.541476681856;5693.373728889819;5730.856728581819;5769.59612827098;5802.941970580325;5832.504237139806;6316.810495685137;6366.076918846741;6441.355864413521;6449.935500645028;6462.095306657072;6669.499787515956;6679.966600166968;6681.09805176295;6696.062551242732;6781.830454238486;6178.969105154445;6241.282252541016;6357.459615932513;6375.234971803413;6393.1369265148605;6570.375814297634;6586.47308215332;6624.90062649051;6656.7004484797335;6667.966660166668;6507.6746162692625;6741.393274605309;6743.527953043436;6749.49378796602;6817.2501024888215;6492.091107244895;6506.186726659168;6583.835404114935;6591.110200122922;6593.670316484061;6263.09185168139;6340.112384266298;6367.586106903036;6372.490200784019;6577.473802095725;6364.554481186273;6375.713092910923;6437.742490300523;6484.967575162094;6491.967540162269;6574.638394888327;6575.243846957661;6636.369544893228;6641.900371494335;6676.065350850788;6363.077353783768;6365.299817020032;6371.203599550056;6422.389872962061;6445.484361250995 16:07:00 INFO - PID 3737 | |1;ext.html;795.8209402884349;810.9513429194247;819.2053707903332;821.1624143373755;821.4701517521199;38532.80733596331;42490.36264456036;42734.35898461518;42860.142797144035;42952.78523607382;39364.409533856946;39486.40770388446;39587.60412395875;39694.80152599233;39775.60224397755;6809.59142451452;6864.862702745942;6901.689423975908;6925.238223795379;7546.2076481969425;7497.587632680201;7613.619319034054;7656.119546252196;7657.11943126542;7658.9617051914665;7639.847203055935;7640.656170472342;7680.385569154482;7687.346575541086;7701.8844717329;7514.887276690882;7559.28186822251;7594.164641889388;7627.961860190719;7639.656215470317;7433.702651893972;7515;7536.510126841793;7581.052368453943;7602.1257555380735;36833;37112;37140;37239.441408378894;37243.4413483798;3446.827658617059;3461.273132642148;3461.978716278704;3481.0775144586705;3485.2158264390564;31210.843945780354;31214.687853121406;31219.063428096968;31238.843805780827;31379.05862824119;5037.294778730944;5182.611304152166;5202.479752024805;5224.555912747421;5301.867453313659;181017;181059.09470452694;181108;183349;184227;40963.180736385104;41513.999999999396;47389.5261047392;47974;48395;50141.74929125331;50218.246726299134;50595.494045059815;50850;50910;14253.572392828231;14288.42846286137;14404.135751854923;14509.129452232899;14516.491922782652;11537.365444900612;11591.76816463666;11639.941800290944;11706.531738730355;11756.353400563052;13577.932110339385;13599.59201223965;13643.249621270925;13670.794938075936;13741.931290343484;5444.5916556258435;5448.91826622601;5568.136938774496;5605.943940560543;5642.689652069093;993.9105480506789;1003.7641154328727;1013.3312014070679;1014.9340292880939;1023.8208313545249;22536.661950070764;22682.773172268397;22729.659055114185;23170.42073948131;23177.7682223179;1092.7927479204998;1101.5098281264761;1109.1899325815687;1109.4452773613193;1113.5768408004906;12113.757724845455;12260.570880019157;12326.260424374566;12416.441260143316;12421.93789031049;209284;211660;212116;212978;213017;52264;52301.7384913073;52481.2127818083;52545.211821822704;52687.473125268254;1359.9252041137831;1399.3353157250428;1422.1609250542024;1424.0814674535075;1435.2608406670572;22518.662220066384;22905.8547072649;23069;23125.306240812803;23145.768542315036;36656.45015324825;36696;36827.63172368242;37043.62956370402;37130.07174820543;178366;179083.10458447624;181174;182393.44016399165;183009.08495457438;30145.849270754385;32143.678563214067;32489.512657309686;34168.48747268843;34653.65346346605;43078.13843723045;43391;43507;43512.78243608762;43625.345619815096;31607.525887111253;31695.207619809687;31822.840885795424;31939.680603193672;31998.52002219922;30942;31035.84482077575;31235.843820780752;31707.365852683277;31737.365252694355;34830;35411.46882796709;35905.28189436145;35927.640723593475;36029.45955810718;30314.242143946576;30415.695843041285;30550.847245763627;31448;31773.682263177074;23858.642120368557;23871.880640596686;23875;23878.52242955166;24064.51870962606 16:07:00 INFO - PID 3737 | |2;jquery.html;549.1186645434078;551.2062629813068;560.6159780550325;567.8466813960231;570.1874828369573;22170.667439988392;22957.4260643484;23051;23074;23092.07631694732;23433.882830585822;24079.75920240797;24092.518149636995;24456;24506.14228502003;6226.782062627798;6399.584027038228;6416.903746443807;6419.743210271607;6456.257530383996;6337.651429171394;6396.968015159918;6414.454771344442;6418.293987661354;6419.844428002958;6158.753649854;6350.61896286222;6374.17135772349;6381.904271435932;6400.263969643481;6354.046892966069;6359.20509936258;6372.171617689717;6395.584287021329;6403.327650596691;5913.526917846562;5937.940620593782;5942.405759424067;5950.256217972754;5959.940400595982;27188.728112718818;27520.311992200153;27549.86225068882;27621.447571048466;27647.58528622052;2012.2152360579387;2019.8586098973078;2021.242034237161;2030.8172264496118;2042.4995876010323;17782.91108544462;18599.44201673952;18602.34891778795;18617.813821861742;18641.7203741944;2351.1183306260154;2368.3250273672093;2379.6311571706415;2380.6310021946624;2380.964285535701;116498;121325;123262;128354;129181.70818291791;14370.497032604018;14464.855351446562;14526.273686315642;14546.854531454761;14806.851931480764;22094.779052209593;22401.767902765503;22435.887820561118;22453.32640020802;22465.77534224637;9175.495347755937;9351.859722104175;9465.810683786285;9502.239820814457;9511.524423778783;8545.829083418297;8683.609237584198;8735.868961965576;8815.603297851612;8821.911780882238;8552.358573107042;8736.985739919717;8766.298696104424;8856.848609680701;8930.50882201472;2532.645429639852;2571.515596366896;2591.209681047261;2596.9610455843176;2704.148193319098;942.3356533643764;953.3850666320185;965.8020105878278;966.7565318356952;970.6263088710756;18823.71764423535;19066.428007159808;19082.33211837579;19092.045397730057;19520.804791951898;993.7068564773409;1004.2417974429259;1006.1900170362782;1008.7578981044496;1009.3741880034426;10354.689359319233;10492.16062714981;10595.84106238407;10617.628383006559;10846.566137354417;468290;471021;476702;480280;485238;103690.48154759179;105471.47264263629;106469.46765266125;106875;107074;1100.944952752359;1103.8730545987153;1127.8984891359817;1129.9774004519863;1131.8342107629155;16696.248668810174;16717.331306747594;16763.748543772097;16783.832161678227;16832.663346733243;53856.73071634617;54574.45425545853;54975.72512137414;55667;55779;67086.32913670996;67211.66394168194;67408.6629566849;67940;68127.63744725176;13803.723925521634;13926.51257205993;13984.930075349965;14055.297235138407;14084.15495070299;21325.6801147986;21357.14571417126;21371.358859233627;21593.568128637653;21700.45748856291;17220.569485762957;17336.39322623702;17387.217575209397;17534.473965781046;17582.560435989202;15495.225238738243;15563.45527906563;15941.644960178515;16301.347946082024;16482.25829837684;18074.825136366093;18261.726074108632;18307.450776476726;18391;18400.89594624327;13783.931080344935;13801.930990344985;13810.585682429542;13823.447062117804;13848.723025539633;17223.397181099102;17292;17392;17533.912330438267;17565.12174391301 16:07:00 INFO - PID 3737 | |3;mootools.html;1296.2028352563173;1371.9999999999998;1389.9513517026905;1403.3754979034327;1404.5996890886092;14785.26073696315;15356.69286614267;15364;15367;15392.769108463383;15047.24763761813;15051.62370940727;15090.924545377258;15176.84823151768;15201;2695.7439043290956;2720.483108209439;2759.4205216904375;2762.1713485954233;2762.337039110619;2711.3221694576355;2713.091114476643;2713.4437440324787;2714.796390270728;2715.7827373810146;2604.830686005413;2615.4115324052127;2616.28052285622;2637.0243010086297;2648.4570663014038;2470.197185914576;2526.570483017882;2532.240327901622;2536.087008676884;2545.5927051671642;2428.4171798768343;2428.659987601737;2430.7083150021936;2431.501542183848;2435.683361163055;14186.432542698383;14370.712585748226;14389.280535973265;14415.639609009753;14426.783598246035;7710;7978.800529986739;7991.361770836965;8006.759797206093;8022.27799498048;4913.975430122862;4967.677100988461;4979.775910084055;5086.287919691246;5232.8691782705355;1915.808419158087;1929.7394851694983;1935.525796179931;1943.9611207775765;1979.356709069558;23551.528969420688;23804.642930356058;24045.87977060121;25306.1142859999;25573.616395754078;6950.235474097845;7092.6289313100415;7185.568865868065;7219.526685810414;7241.2396698346965;19820.108095135754;19823.207071717257;19859.503512412306;19926.900365498368;20063.498412539804;7663.9616801916745;7734.5359278443475;7794.493357931717;8054.395920305883;8071.4349995500925;7028.683709233097;7200.603966781878;7401.037865077506;7429.07136607924;7433.628318584049;5261.447548007404;5398;5429.972850135724;5450.127979523258;5550.5282051026115;1694.788151481065;1731.1690388613536;1740.443058221357;1752.3253547384095;1784.9018303993146;859.4327743689136;877.0834477970536;894.5884892949186;896.852019416789;899.2086963472234;7629.618519074135;7691.346235569928;7714.267144621252;7782.922170778333;7927.841443171104;692.941100006495;693.569986608296;694.8436601764664;699.9335063168991;700.4816435837444;4226.4716910386205;4238.158380108277;4244.0026593750445;4255.489341279066;4286.678499112579;20122;21179.788202117783;21192.470188245108;21437.464063398227;21469.78530214709;19912.60174796496;20490.487737806376;21106;21136.365909022756;21194.894025529775;10247.538860751283;10410.68767936963;10424.322419042737;10485.475726213659;10609.310394824312;7878.606069696607;8044.074931382732;8119.959400202961;8177.918220817715;8280.958595207227;17212.569685757957;17875.46373608794;17927;17972.82027179764;18149.455516334532;18026.81973180304;18041.1881465337;18155;18741.250349985847;19235;10961.83557246626;11448.82826757616;11546.94226528862;11574.305541667527;11620.418979050844;13519.797203042159;13671.521496747566;13690.93154534221;13711.794323084961;13738.381772820047;10617;10816.4050977197;10947.671569852917;10950.34297942126;11078.612248571262;10666.73333166677;10693.0752464554;10706.197035222545;10777.568897244022;10789.1368690503;9275.953620232125;9394.624215031323;9450.291228158054;9476.668316608886;9577.760555986157;6845.110135682528;6900.896486552806;6921.584704917721;6966;6997.930020699931;6799.048133261248;6910.308969103049;6923.9653801730665;6946.0970073892095;7046.907729301966 16:07:00 INFO - PID 3737 | |4;prototype.html;486.90018546198036;497.43292646383117;506.9366329208848;507.4139369028773;519.5350161605363;6204.627722336663;6218.37816218378;6220.751169953202;6255.687215639211;6262.248530176385;6059.454649081582;6111.969440152793;6148.1392605035335;6155.599886007418;6192.934497423782;5093;5097.3118628984985;5102.948970510284;5108.591312694975;5129.846104616868;5063.480955713289;5121.897562048757;5136.717480538568;5144.09978253806;5166.199239117943;4773.594244489223;4894.119058569456;4920.70475771453;4920.9911968046645;5040.924386134211;4811.615070794363;4853.417589889236;4904.656674032819;4931.753412329387;4959.727215003173;4260.914781704349;4376.978115109436;4400.383946247528;4401.603855653007;4429.844955426544;6004.729787159545;6013.188219590343;6028.7588496460085;6035.456808887221;6076.513878889678;5560.49866536033;5569.554435645138;5606.6636001840025;5646.265985421869;5657.688827114507;6459.289478157399;6490;6496.285408605049;6498.415142637185;6502.837429064264;4513.487981526193;4788.209945359012;4790.473047964721;4793.664443488957;4805.5434733700595;6558.639274839882;6671.833204169886;6707.765228216989;6745.2580216176675;6787.423069039138;4767.570918617341;4807.375041244616;4840.806367745321;4845.370101886732;4849.854504364875;4874.561289483963;4884.705553028451;4897.216445368724;4909.950900491021;4944.739091531636;5458.208559758813;5478.643888147338;5528.253685752452;5539.695316757617;5598.552115830724;6444.709988050456;6539.378759017885;6547;6550.868982620416;6560.573562718408;1673.6652669466155;1686.1316422042657;1711.880168388201;1715;1720.1829131162847;1131.3947038334452;1160.7985734764648;1161.8903946730852;1183.5620820296544;1190.0776897904193;5587.413321601254;5596.2165296858475;5601.215829783833;5624.3813180550105;5636.408177141423;6628.171478565179;6638.705452436825;6640.169978752656;6654.900176497356;6709.329067093252;5560.138178582326;5569.66582005081;5593.664380137205;5625.774969001194;5647.548196144298;3482.4776283557667;3484.930301393958;3509.2104276538084;3540.2742437800703;3542.6634469725336;6153.7230824613;6235.625862448268;6274.592151510137;6306.400891915261;6359.523035772243;6552.246491653425;6685.53201275906;6731.360520750521;6799.218089919624;6819.522633415613;6240.875182496416;6253.624782513064;6303.149074874925;6334.208223972004;6345.96827015862;6464.868647986489;6523.510736694672;6565.507586931095;6569.977810207358;6620.933790662032;6393.936060639334;6464.353564643498;6485.254195767358;6510.5117116217425;6529.281779004401;5714.9142762857755;6212.4408803207925;6225.564210505221;6233.563650544418;6261.373862613702;4809.302651115639;4810.735409552508;4814.422269327703;4827.782749776339;4849.393825771778;6220.564560480904;6442.613443193236;6527.967360163168;6561.934380656132;6676.0987266718375;6249.96875015622;6301.282243476371;6314.147590075281;6363.427291543783;6462.676866156768;6313.684315784284;6390.520710946605;6424;6482.57863238888;6496.9025464617125;6339.683015849281;6351.555391122577;6397.96801015992;6428.55000149985;6443.548951573345;6478.838029049311;6500.479961602966;6512.73949042033;6565.540412171294;6567.802965911031;6257.812265632038;6262.655553944577;6307.526935479766;6326.367363263821;6331.398517140864 16:07:00 INFO - PID 3737 | |5;yui.html;838.9496630202186;853.2193043365321;858.223307906345;861.7974775927657;865.3596338709357;15923.442679506219;16149.596260093504;16464.341426342933;16480.917595412022;16538.83461165388;15799.684006319867;16280.511584652479;16372.690184785219;16452.259648315823;16456.506304810875;923.6166990698852;942.1002942190227;942.3968660057569;942.8491441369348;944.9338546301761;922.796984663373;924.8612708093773;925.0240995749482;934.2105920497169;965.377331621104;1011.2163073617932;1021.1830535571551;1034.105498743585;1034.493098381795;1035.7203555040135;1021.2748948246754;1022.4785359466688;1029.2332212501733;1031.6234574380296;1032.9690109296732;712.779038498062;726.7165805335924;727.1855521815547;728.144430294402;732.0300601702712;16653.583660408465;16833.91583042089;16888.915555422267;16897.91551042237;16993.150342482826;20913.581728365498;20999.89500052505;21315.25396611111;21468.5706285875;21593.136274549;16837.663246734995;16878.071706056162;16918.492445226664;17074.573135671584;17200.741988870177;3330.0509354834;3366.4445366514497;3373.645767194458;3378.746594005435;3382.6109997350372;136556;138602.3069884644;139366;142071.2896435511;142999;16274.349026038826;16394;16414.015159090493;16803.747943780854;16830.15849207535;31059.534106988413;31504.212394690316;31673.8416307917;31738.36523269568;32384;7651.923480765233;7746.612669366509;7768.067831860213;7788.532688038736;7797;4026.074002979331;4059.8579049733116;4094.4267802507675;4098.139390727981;4133.379993001014;5239.921401178985;5278.155495120839;5293.602979776532;5349.625526213205;5390.21841832932;852.4953457148139;853.5945425922637;873.7466134820958;875.1817051057282;879.3932186791094;644.2526669063864;647.4529022975578;656.2158220926043;670.1054092786088;672.042339665974;10774.24580279373;10873.184511161695;11183.72040698989;11387.373694446886;11955.88044119565;636.8694417644465;644.490852226745;647.782169521297;659.4361820643377;665.125360151409;5323.707196104251;5434.565234781208;5575.749091290902;5591.720413979366;5648.265725455664;119188.40405797916;123081.38459307826;123277.38361308136;123427;128989.35505322414;99574.50212749034;104389;107306;109044;111002;91797;92525;94512;94856;94906.52546737222;9655.565499552396;9753.853692194765;9766.414015159113;9879.753006174904;10009.999000099931;42785;43060.56939430691;44467.55532444763;44691.776541117084;45589;57285.42714572801;57935;58568;58982;59109.704451479185;13924.955628327712;14409.13545187292;14584.781228281796;14839.40642374293;14850.702985940005;17461.30154793794;17536.298548057934;17652.20565074549;17684.557886052953;17903.820961790738;14289.71420571562;14428.927855361077;14474.203918784568;14479.565613031626;14691.926540367229;14978.400863965755;15093.47172848945;15118.773218401513;15233.314500847267;15543.145127018122;15447.150406727738;15636.218189090272;15686.764698529303;15740;15807.762883556527;10755.516001780095;10934.507947142556;11003.779924401628;11303.1522635801;11352.148588855704;10592.682219533426;10594.205434592282;10758.300710453796;10764.784704306026;11030.22788404804 16:07:00 INFO - PID 3737 | __end_tp_report 16:07:00 INFO - PID 3737 | __start_cc_report 16:07:00 INFO - PID 3737 | _x_x_mozilla_cycle_collect,375 16:07:00 INFO - PID 3737 | __end_cc_report 16:07:00 INFO - PID 3737 | __startTimestamp1505171220566__endTimestamp 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | ------- Summary: start ------- 16:07:00 INFO - PID 3737 | Number of tests: 6 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | [#0] dojo.html Cycles:165 Average:6091.16 Median:6365.30 stddev:841.84 (13.2%) stddev-sans-first:809.31 16:07:00 INFO - PID 3737 | Values: 3024.3 3115.1 3118.4 3139.3 3141.3 6039.2 6243.1 6243.9 6283.3 6341.6 6105.1 6111.1 6112.0 6120.0 6129.3 5588.0 5613.8 5645.6 5666.1 5720.3 5694.1 5725.7 5759.7 5828.9 5888.7 5780.7 5836.4 5846.7 5851.7 5852.7 933.2 5794.8 5843.3 5864.3 5870.5 5085.4 5632.7 5637.7 5658.9 5735.9 6142.3 6148.4 6174.5 6223.6 6281.9 6586.0 6684.8 6700.3 6757.2 6766.6 6724.9 6734.7 6739.8 6838.9 6846.9 6026.2 6127.9 6235.2 6297.7 6309.6 6721.4 6753.4 6757.5 6765.5 6851.5 6531.7 6551.9 6555.6 6573.5 6596.3 6614.7 6667.2 6679.3 6712.6 6727.1 6590.1 6610.7 6611.6 6692.1 6743.4 6467.4 6606.6 6645.3 6650.6 6657.7 5241.3 5248.1 5262.3 5263.6 5267.7 4559.1 4579.7 4586.0 4587.8 4605.2 5630.0 5701.5 5706.0 5706.6 5728.2 6556.2 6596.2 6651.8 6661.0 6704.6 5606.5 5640.3 5704.5 5711.1 5731.5 5693.4 5730.9 5769.6 5802.9 5832.5 6316.8 6366.1 6441.4 6449.9 6462.1 6669.5 6680.0 6681.1 6696.1 6781.8 6179.0 6241.3 6357.5 6375.2 6393.1 6570.4 6586.5 6624.9 6656.7 6668.0 6507.7 6741.4 6743.5 6749.5 6817.3 6492.1 6506.2 6583.8 6591.1 6593.7 6263.1 6340.1 6367.6 6372.5 6577.5 6364.6 6375.7 6437.7 6485.0 6492.0 6574.6 6575.2 6636.4 6641.9 6676.1 6363.1 6365.3 6371.2 6422.4 6445.5 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | [#1] ext.html Cycles:180 Average:35922.96 Median:19057.82 stddev:49726.18 (260.9%) stddev-sans-first:49795.72 16:07:00 INFO - PID 3737 | Values: 795.8 811.0 819.2 821.2 821.5 38532.8 42490.4 42734.4 42860.1 42952.8 39364.4 39486.4 39587.6 39694.8 39775.6 6809.6 6864.9 6901.7 6925.2 7546.2 7497.6 7613.6 7656.1 7657.1 7659.0 7639.8 7640.7 7680.4 7687.3 7701.9 7514.9 7559.3 7594.2 7628.0 7639.7 7433.7 7515.0 7536.5 7581.1 7602.1 36833.0 37112.0 37140.0 37239.4 37243.4 3446.8 3461.3 3462.0 3481.1 3485.2 31210.8 31214.7 31219.1 31238.8 31379.1 5037.3 5182.6 5202.5 5224.6 5301.9 181017.0 181059.1 181108.0 183349.0 184227.0 40963.2 41514.0 47389.5 47974.0 48395.0 50141.7 50218.2 50595.5 50850.0 50910.0 14253.6 14288.4 14404.1 14509.1 14516.5 11537.4 11591.8 11639.9 11706.5 11756.4 13577.9 13599.6 13643.2 13670.8 13741.9 5444.6 5448.9 5568.1 5605.9 5642.7 993.9 1003.8 1013.3 1014.9 1023.8 22536.7 22682.8 22729.7 23170.4 23177.8 1092.8 1101.5 1109.2 1109.4 1113.6 12113.8 12260.6 12326.3 12416.4 12421.9 209284.0 211660.0 212116.0 212978.0 213017.0 52264.0 52301.7 52481.2 52545.2 52687.5 1359.9 1399.3 1422.2 1424.1 1435.3 22518.7 22905.9 23069.0 23125.3 23145.8 36656.5 36696.0 36827.6 37043.6 37130.1 178366.0 179083.1 181174.0 182393.4 183009.1 30145.8 32143.7 32489.5 34168.5 34653.7 43078.1 43391.0 43507.0 43512.8 43625.3 31607.5 31695.2 31822.8 31939.7 31998.5 30942.0 31035.8 31235.8 31707.4 31737.4 34830.0 35411.5 35905.3 35927.6 36029.5 30314.2 30415.7 30550.8 31448.0 31773.7 23858.6 23871.9 23875.0 23878.5 24064.5 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | [#2] jquery.html Cycles:180 Average:33112.60 Median:23004.21 stddev:79759.07 (346.7%) stddev-sans-first:79945.34 16:07:00 INFO - PID 3737 | Values: 549.1 551.2 560.6 567.8 570.2 22170.7 22957.4 23051.0 23074.0 23092.1 23433.9 24079.8 24092.5 24456.0 24506.1 6226.8 6399.6 6416.9 6419.7 6456.3 6337.7 6397.0 6414.5 6418.3 6419.8 6158.8 6350.6 6374.2 6381.9 6400.3 6354.0 6359.2 6372.2 6395.6 6403.3 5913.5 5937.9 5942.4 5950.3 5959.9 27188.7 27520.3 27549.9 27621.4 27647.6 2012.2 2019.9 2021.2 2030.8 2042.5 17782.9 18599.4 18602.3 18617.8 18641.7 2351.1 2368.3 2379.6 2380.6 2381.0 116498.0 121325.0 123262.0 128354.0 129181.7 14370.5 14464.9 14526.3 14546.9 14806.9 22094.8 22401.8 22435.9 22453.3 22465.8 9175.5 9351.9 9465.8 9502.2 9511.5 8545.8 8683.6 8735.9 8815.6 8821.9 8552.4 8737.0 8766.3 8856.8 8930.5 2532.6 2571.5 2591.2 2597.0 2704.1 942.3 953.4 965.8 966.8 970.6 18823.7 19066.4 19082.3 19092.0 19520.8 993.7 1004.2 1006.2 1008.8 1009.4 10354.7 10492.2 10595.8 10617.6 10846.6 468290.0 471021.0 476702.0 480280.0 485238.0 103690.5 105471.5 106469.5 106875.0 107074.0 1100.9 1103.9 1127.9 1130.0 1131.8 16696.2 16717.3 16763.7 16783.8 16832.7 53856.7 54574.5 54975.7 55667.0 55779.0 67086.3 67211.7 67408.7 67940.0 68127.6 13803.7 13926.5 13984.9 14055.3 14084.2 21325.7 21357.1 21371.4 21593.6 21700.5 17220.6 17336.4 17387.2 17534.5 17582.6 15495.2 15563.5 15941.6 16301.3 16482.3 18074.8 18261.7 18307.5 18391.0 18400.9 13783.9 13801.9 13810.6 13823.4 13848.7 17223.4 17292.0 17392.0 17533.9 17565.1 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | [#3] mootools.html Cycles:180 Average:9113.51 Median:13919.18 stddev:6522.32 (46.9%) stddev-sans-first:6514.17 16:07:00 INFO - PID 3737 | Values: 1296.2 1372.0 1390.0 1403.4 1404.6 14785.3 15356.7 15364.0 15367.0 15392.8 15047.2 15051.6 15090.9 15176.8 15201.0 2695.7 2720.5 2759.4 2762.2 2762.3 2711.3 2713.1 2713.4 2714.8 2715.8 2604.8 2615.4 2616.3 2637.0 2648.5 2470.2 2526.6 2532.2 2536.1 2545.6 2428.4 2428.7 2430.7 2431.5 2435.7 14186.4 14370.7 14389.3 14415.6 14426.8 7710.0 7978.8 7991.4 8006.8 8022.3 4914.0 4967.7 4979.8 5086.3 5232.9 1915.8 1929.7 1935.5 1944.0 1979.4 23551.5 23804.6 24045.9 25306.1 25573.6 6950.2 7092.6 7185.6 7219.5 7241.2 19820.1 19823.2 19859.5 19926.9 20063.5 7664.0 7734.5 7794.5 8054.4 8071.4 7028.7 7200.6 7401.0 7429.1 7433.6 5261.4 5398.0 5430.0 5450.1 5550.5 1694.8 1731.2 1740.4 1752.3 1784.9 859.4 877.1 894.6 896.9 899.2 7629.6 7691.3 7714.3 7782.9 7927.8 692.9 693.6 694.8 699.9 700.5 4226.5 4238.2 4244.0 4255.5 4286.7 20122.0 21179.8 21192.5 21437.5 21469.8 19912.6 20490.5 21106.0 21136.4 21194.9 10247.5 10410.7 10424.3 10485.5 10609.3 7878.6 8044.1 8120.0 8177.9 8281.0 17212.6 17875.5 17927.0 17972.8 18149.5 18026.8 18041.2 18155.0 18741.3 19235.0 10961.8 11448.8 11546.9 11574.3 11620.4 13519.8 13671.5 13690.9 13711.8 13738.4 10617.0 10816.4 10947.7 10950.3 11078.6 10666.7 10693.1 10706.2 10777.6 10789.1 9276.0 9394.6 9450.3 9476.7 9577.8 6845.1 6900.9 6921.6 6966.0 6997.9 6799.0 6910.3 6924.0 6946.1 7046.9 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | [#4] prototype.html Cycles:180 Average:5404.79 Median:6067.98 stddev:1516.21 (25.0%) stddev-sans-first:1474.85 16:07:00 INFO - PID 3737 | Values: 486.9 497.4 506.9 507.4 519.5 6204.6 6218.4 6220.8 6255.7 6262.2 6059.5 6112.0 6148.1 6155.6 6192.9 5093.0 5097.3 5102.9 5108.6 5129.8 5063.5 5121.9 5136.7 5144.1 5166.2 4773.6 4894.1 4920.7 4921.0 5040.9 4811.6 4853.4 4904.7 4931.8 4959.7 4260.9 4377.0 4400.4 4401.6 4429.8 6004.7 6013.2 6028.8 6035.5 6076.5 5560.5 5569.6 5606.7 5646.3 5657.7 6459.3 6490.0 6496.3 6498.4 6502.8 4513.5 4788.2 4790.5 4793.7 4805.5 6558.6 6671.8 6707.8 6745.3 6787.4 4767.6 4807.4 4840.8 4845.4 4849.9 4874.6 4884.7 4897.2 4910.0 4944.7 5458.2 5478.6 5528.3 5539.7 5598.6 6444.7 6539.4 6547.0 6550.9 6560.6 1673.7 1686.1 1711.9 1715.0 1720.2 1131.4 1160.8 1161.9 1183.6 1190.1 5587.4 5596.2 5601.2 5624.4 5636.4 6628.2 6638.7 6640.2 6654.9 6709.3 5560.1 5569.7 5593.7 5625.8 5647.5 3482.5 3484.9 3509.2 3540.3 3542.7 6153.7 6235.6 6274.6 6306.4 6359.5 6552.2 6685.5 6731.4 6799.2 6819.5 6240.9 6253.6 6303.1 6334.2 6346.0 6464.9 6523.5 6565.5 6570.0 6620.9 6393.9 6464.4 6485.3 6510.5 6529.3 5714.9 6212.4 6225.6 6233.6 6261.4 4809.3 4810.7 4814.4 4827.8 4849.4 6220.6 6442.6 6528.0 6561.9 6676.1 6250.0 6301.3 6314.1 6363.4 6462.7 6313.7 6390.5 6424.0 6482.6 6496.9 6339.7 6351.6 6398.0 6428.6 6443.5 6478.8 6500.5 6512.7 6565.5 6567.8 6257.8 6262.7 6307.5 6326.4 6331.4 16:07:00 INFO - PID 3737 | 16:07:00 INFO - PID 3737 | [#5] yui.html Cycles:180 Average:23776.55 Median:20956.74 stddev:35303.75 (168.5%) stddev-sans-first:35360.78 16:07:00 INFO - PID 3737 | Values: 838.9 853.2 858.2 861.8 865.4 15923.4 16149.6 16464.3 16480.9 16538.8 15799.7 16280.5 16372.7 16452.3 16456.5 923.6 942.1 942.4 942.8 944.9 922.8 924.9 925.0 934.2 965.4 1011.2 1021.2 1034.1 1034.5 1035.7 1021.3 1022.5 1029.2 1031.6 1033.0 712.8 726.7 727.2 728.1 732.0 16653.6 16833.9 16888.9 16897.9 16993.2 20913.6 20999.9 21315.3 21468.6 21593.1 16837.7 16878.1 16918.5 17074.6 17200.7 3330.1 3366.4 3373.6 3378.7 3382.6 136556.0 138602.3 139366.0 142071.3 142999.0 16274.3 16394.0 16414.0 16803.7 16830.2 31059.5 31504.2 31673.8 31738.4 32384.0 7651.9 7746.6 7768.1 7788.5 7797.0 4026.1 4059.9 4094.4 4098.1 4133.4 5239.9 5278.2 5293.6 5349.6 5390.2 852.5 853.6 873.7 875.2 879.4 644.3 647.5 656.2 670.1 672.0 10774.2 10873.2 11183.7 11387.4 11955.9 636.9 644.5 647.8 659.4 665.1 5323.7 5434.6 5575.7 5591.7 5648.3 119188.4 123081.4 123277.4 123427.0 128989.4 99574.5 104389.0 107306.0 109044.0 111002.0 91797.0 92525.0 94512.0 94856.0 94906.5 9655.6 9753.9 9766.4 9879.8 10010.0 42785.0 43060.6 44467.6 44691.8 45589.0 57285.4 57935.0 58568.0 58982.0 59109.7 13925.0 14409.1 14584.8 14839.4 14850.7 17461.3 17536.3 17652.2 17684.6 17903.8 14289.7 14428.9 14474.2 14479.6 14691.9 14978.4 15093.5 15118.8 15233.3 15543.1 15447.2 15636.2 15686.8 15740.0 15807.8 10755.5 10934.5 11003.8 11303.2 11352.1 10592.7 10594.2 10758.3 10764.8 11030.2 16:07:00 INFO - PID 3737 | -------- Summary: end -------- 16:07:00 INFO - PID 3737 | 16:07:01 INFO - TEST-INFO | 3737: exit 0 16:07:01 INFO - TEST-OK | dromaeo_css | took 1116792ms 16:07:01 INFO - TEST-START | kraken 16:07:01 INFO - Initialising browser for kraken test... 16:07:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48620/getInfo.html -profile /tmp/tmpiN1a7V/profile 16:07:01 INFO - TEST-INFO | started process 4132 (/builds/slave/test/build/application/firefox/firefox http://localhost:48620/getInfo.html) 16:07:07 INFO - TEST-INFO | 4132: exit 0 16:07:07 INFO - Browser initialized. 16:07:07 INFO - Running cycle 1/1 for kraken test... 16:07:07 INFO - Using env: {'DISPLAY': ':0', 16:07:07 INFO - 'HOME': '/home/cltbld', 16:07:07 INFO - 'JSGC_DISABLE_POISONING': '1', 16:07:07 INFO - 'LANG': 'en_US.UTF-8', 16:07:07 INFO - 'LANGUAGE': 'en_US:en', 16:07:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:07:07 INFO - 'LOGNAME': 'cltbld', 16:07:07 INFO - 'MAIL': '/var/mail/cltbld', 16:07:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:07 INFO - 'MOZ_ACCELERATED': '1', 16:07:07 INFO - 'MOZ_CRASHREPORTER': '1', 16:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:07:07 INFO - 'MOZ_NO_REMOTE': '1', 16:07:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:07 INFO - 'MOZ_WEBRENDER': '1', 16:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:07 INFO - 'NO_EM_RESTART': '1', 16:07:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:07 INFO - 'PWD': '/builds/slave/test', 16:07:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:07 INFO - 'RUST_BACKTRACE': 'full', 16:07:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:07:07 INFO - 'SHELL': '/bin/bash', 16:07:07 INFO - 'SHLVL': '1', 16:07:07 INFO - 'TERM': 'linux', 16:07:07 INFO - 'TMOUT': '86400', 16:07:07 INFO - 'USER': 'cltbld', 16:07:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036', 16:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:07 INFO - '_': '/tools/buildbot/bin/python'} 16:07:07 INFO - TEST-INFO | started process 4341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiN1a7V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:08 INFO - PID 4341 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:07:08 INFO - PID 4341 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:07:09 INFO - PID 4341 | 16:07:09 INFO - PID 4341 | (/builds/slave/test/build/application/firefox/firefox:4403): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:07:09 INFO - PID 4341 | 16:07:19 INFO - PID 4341 | RSS: Main: 215146496 16:07:19 INFO - PID 4341 | 16:07:22 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48620/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:23 INFO - PID 4341 | RSS: Main: 220975104 16:07:23 INFO - PID 4341 | 16:07:25 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48620/tests/kraken/driver.html?testName=audio-dft) 16:07:26 INFO - PID 4341 | RSS: Main: 222711808 16:07:26 INFO - PID 4341 | 16:07:29 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48620/tests/kraken/driver.html?testName=audio-fft) 16:07:30 INFO - PID 4341 | RSS: Main: 216641536 16:07:30 INFO - PID 4341 | 16:07:32 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48620/tests/kraken/driver.html?testName=audio-oscillator) 16:07:33 INFO - PID 4341 | RSS: Main: 217587712 16:07:33 INFO - PID 4341 | 16:07:35 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:35 INFO - PID 4341 | RSS: Main: 217346048 16:07:35 INFO - PID 4341 | 16:07:39 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48620/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:39 INFO - PID 4341 | RSS: Main: 220680192 16:07:39 INFO - PID 4341 | 16:07:43 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48620/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:44 INFO - PID 4341 | RSS: Main: 218664960 16:07:44 INFO - PID 4341 | 16:07:47 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48620/tests/kraken/driver.html?testName=json-parse-financial) 16:07:47 INFO - PID 4341 | RSS: Main: 220893184 16:07:47 INFO - PID 4341 | 16:07:49 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:50 INFO - PID 4341 | RSS: Main: 220868608 16:07:50 INFO - PID 4341 | 16:07:52 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:52 INFO - PID 4341 | RSS: Main: 221110272 16:07:52 INFO - PID 4341 | 16:07:54 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:55 INFO - PID 4341 | RSS: Main: 221573120 16:07:55 INFO - PID 4341 | 16:07:58 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:58 INFO - PID 4341 | RSS: Main: 222109696 16:07:58 INFO - PID 4341 | 16:08:01 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:02 INFO - PID 4341 | RSS: Main: 222523392 16:08:02 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | Cycle 1(1): loaded http://localhost:48620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48620/tests/kraken/driver.html?testName=ai-astar) 16:08:04 INFO - PID 4341 | RSS: Main: 222859264 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | __start_tp_report 16:08:04 INFO - PID 4341 | _x_x_mozilla_page_load 16:08:04 INFO - PID 4341 | _x_x_mozilla_page_load_details 16:08:04 INFO - PID 4341 | |i|pagename|runs| 16:08:04 INFO - PID 4341 | |0;ai-astar;111;116;116;114;110;115;108;107;107;107 16:08:04 INFO - PID 4341 | |1;audio-beat-detection;118;116;115;147;123;119;123;122;116;117 16:08:04 INFO - PID 4341 | |2;audio-dft;172;168;166;170;172;171;164;165;167;177 16:08:04 INFO - PID 4341 | |3;audio-fft;76;74;75;75;85;82;77;77;84;76 16:08:04 INFO - PID 4341 | |4;audio-oscillator;85;87;79;82;80;87;79;83;85;80 16:08:04 INFO - PID 4341 | |5;imaging-gaussian-blur;115;111;125;117;123;114;117;114;127;116 16:08:04 INFO - PID 4341 | |6;imaging-darkroom;148;158;147;149;150;149;150;149;148;148 16:08:04 INFO - PID 4341 | |7;imaging-desaturate;100;95;95;94;94;101;95;100;97;96 16:08:04 INFO - PID 4341 | |8;json-parse-financial;56;54;57;55;56;57;65;52;53;53 16:08:04 INFO - PID 4341 | |9;json-stringify-tinderbox;37;43;47;38;42;44;47;41;38;46 16:08:04 INFO - PID 4341 | |10;stanford-crypto-aes;82;82;82;76;80;76;84;77;79;76 16:08:04 INFO - PID 4341 | |11;stanford-crypto-ccm;114;119;111;118;123;120;119;118;113;124 16:08:04 INFO - PID 4341 | |12;stanford-crypto-pbkdf2;180;169;168;175;168;170;172;170;169;170 16:08:04 INFO - PID 4341 | |13;stanford-crypto-sha256-iterative;67;72;65;66;72;66;67;68;69;66 16:08:04 INFO - PID 4341 | __end_tp_report 16:08:04 INFO - PID 4341 | __start_cc_report 16:08:04 INFO - PID 4341 | _x_x_mozilla_cycle_collect,949 16:08:04 INFO - PID 4341 | __end_cc_report 16:08:04 INFO - PID 4341 | __startTimestamp1505171284619__endTimestamp 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | ------- Summary: start ------- 16:08:04 INFO - PID 4341 | Number of tests: 14 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.84 (3.4%) stddev-sans-first:4.08 16:08:04 INFO - PID 4341 | Values: 111.0 116.0 116.0 114.0 110.0 115.0 108.0 107.0 107.0 107.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:120.50 stddev:9.41 (7.8%) stddev-sans-first:9.89 16:08:04 INFO - PID 4341 | Values: 118.0 116.0 115.0 147.0 123.0 119.0 123.0 122.0 116.0 117.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#2] audio-dft Cycles:10 Average:169.20 Median:170.50 stddev:3.97 (2.3%) stddev-sans-first:4.08 16:08:04 INFO - PID 4341 | Values: 172.0 168.0 166.0 170.0 172.0 171.0 164.0 165.0 167.0 177.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#3] audio-fft Cycles:10 Average:78.10 Median:77.00 stddev:4.01 (5.2%) stddev-sans-first:4.18 16:08:04 INFO - PID 4341 | Values: 76.0 74.0 75.0 75.0 85.0 82.0 77.0 77.0 84.0 76.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:84.00 stddev:3.16 (3.8%) stddev-sans-first:3.24 16:08:04 INFO - PID 4341 | Values: 85.0 87.0 79.0 82.0 80.0 87.0 79.0 83.0 85.0 80.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.00 stddev:5.28 (4.5%) stddev-sans-first:5.49 16:08:04 INFO - PID 4341 | Values: 115.0 111.0 125.0 117.0 123.0 114.0 117.0 114.0 127.0 116.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.00 stddev:3.10 (2.1%) stddev-sans-first:3.23 16:08:04 INFO - PID 4341 | Values: 148.0 158.0 147.0 149.0 150.0 149.0 150.0 149.0 148.0 148.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:95.00 stddev:2.67 (2.8%) stddev-sans-first:2.55 16:08:04 INFO - PID 4341 | Values: 100.0 95.0 95.0 94.0 94.0 101.0 95.0 100.0 97.0 96.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:3.68 (6.6%) stddev-sans-first:3.90 16:08:04 INFO - PID 4341 | Values: 56.0 54.0 57.0 55.0 56.0 57.0 65.0 52.0 53.0 53.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#9] json-stringify-tinderbox Cycles:10 Average:42.30 Median:43.50 stddev:3.77 (8.7%) stddev-sans-first:3.48 16:08:04 INFO - PID 4341 | Values: 37.0 43.0 47.0 38.0 42.0 44.0 47.0 41.0 38.0 46.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:81.00 stddev:3.03 (3.7%) stddev-sans-first:3.06 16:08:04 INFO - PID 4341 | Values: 82.0 82.0 82.0 76.0 80.0 76.0 84.0 77.0 79.0 76.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:119.00 stddev:4.18 (3.5%) stddev-sans-first:4.18 16:08:04 INFO - PID 4341 | Values: 114.0 119.0 111.0 118.0 123.0 120.0 119.0 118.0 113.0 124.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:170.00 stddev:3.75 (2.2%) stddev-sans-first:2.20 16:08:04 INFO - PID 4341 | Values: 180.0 169.0 168.0 175.0 168.0 170.0 172.0 170.0 169.0 170.0 16:08:04 INFO - PID 4341 | 16:08:04 INFO - PID 4341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.49 (3.7%) stddev-sans-first:2.62 16:08:04 INFO - PID 4341 | Values: 67.0 72.0 65.0 66.0 72.0 66.0 67.0 68.0 69.0 66.0 16:08:04 INFO - PID 4341 | -------- Summary: end -------- 16:08:04 INFO - PID 4341 | 16:08:05 INFO - PID 4341 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:08:05 INFO - TEST-INFO | 4341: exit 0 16:08:06 INFO - TEST-OK | kraken | took 64557ms 16:08:06 INFO - SUITE-END | took 1181s 16:08:06 INFO - Completed test suite (00:19:41) 16:08:06 INFO - javascript benchmark 16:08:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8247.879482330154, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.319528106176, 3115.1121930249883, 3118.423091728032, 3139.3250451153, 3141.27750617358, 6039.214902062726, 6243.094751261065, 6243.906341404882, 6283.340249273829, 6341.619502829822, 6105.084237364386, 6111.144439778434, 6111.969440152804, 6120.0, 6129.295131059929, 5587.972060139704, 5613.775448982035, 5645.633033852807, 5666.121751128561, 5720.313562372521, 5694.088945768678, 5725.656460612356, 5759.68321742304, 5828.883422331551, 5888.7055647217685, 5780.653160810344, 5836.445537673914, 5846.707664616773, 5851.7074146292725, 5852.67810270435, 933.1800465468424, 5794.768209271666, 5843.2695913010875, 5864.266966629171, 5870.471657550841, 5085.364329458817, 5632.690202038886, 5637.689927054011, 5658.91511627326, 5735.942640573582, 6142.293636231846, 6148.354422785588, 6174.475169610543, 6223.626582405071, 6281.937180628181, 6585.967070164666, 6684.766033188864, 6700.329967003309, 6757.155355580552, 6766.560173588701, 6724.856774348373, 6734.730610775563, 6739.797806065826, 6838.863222735517, 6846.931530684679, 6026.186464827279, 6127.908081378783, 6235.158253635746, 6297.748090076391, 6309.558330916838, 6721.395074443323, 6753.425958793558, 6757.459403247728, 6765.492588055916, 6851.520393572402, 6531.738730450824, 6551.934480655133, 6555.573887697285, 6573.52095778446, 6596.274409814917, 6614.669266536654, 6667.199936007613, 6679.265280819106, 6712.630805305755, 6727.058211850345, 6590.110335104795, 6610.669466526654, 6611.636360000246, 6692.096566963398, 6743.393094621508, 6467.417932386108, 6606.570572912745, 6645.269020407752, 6650.600963942179, 6657.733690652417, 5241.266222728821, 5248.1340578804065, 5262.2632831403635, 5263.631545791758, 5267.657602255841, 4559.110973360163, 4579.702319349231, 4585.977070114628, 4587.816487340469, 4605.194091034055, 5629.971850140805, 5701.486866182064, 5705.971470142623, 5706.629069110494, 5728.198052272685, 6556.213254409501, 6596.208454985433, 6651.833704157435, 6661.034150048215, 6704.631245281556, 5606.495415412551, 5640.266765320482, 5704.486596206361, 5711.086226203787, 5731.541476681856, 5693.373728889819, 5730.856728581819, 5769.59612827098, 5802.941970580325, 5832.504237139806, 6316.810495685137, 6366.076918846741, 6441.355864413521, 6449.935500645028, 6462.095306657072, 6669.499787515956, 6679.966600166968, 6681.09805176295, 6696.062551242732, 6781.830454238486, 6178.969105154445, 6241.282252541016, 6357.459615932513, 6375.234971803413, 6393.1369265148605, 6570.375814297634, 6586.47308215332, 6624.90062649051, 6656.7004484797335, 6667.966660166668, 6507.6746162692625, 6741.393274605309, 6743.527953043436, 6749.49378796602, 6817.2501024888215, 6492.091107244895, 6506.186726659168, 6583.835404114935, 6591.110200122922, 6593.670316484061, 6263.09185168139, 6340.112384266298, 6367.586106903036, 6372.490200784019, 6577.473802095725, 6364.554481186273, 6375.713092910923, 6437.742490300523, 6484.967575162094, 6491.967540162269, 6574.638394888327, 6575.243846957661, 6636.369544893228, 6641.900371494335, 6676.065350850788, 6363.077353783768, 6365.299817020032, 6371.203599550056, 6422.389872962061, 6445.484361250995], "value": 6030.602181126605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.8209402884349, 810.9513429194247, 819.2053707903332, 821.1624143373755, 821.4701517521199, 38532.80733596331, 42490.36264456036, 42734.35898461518, 42860.142797144035, 42952.78523607382, 39364.409533856946, 39486.40770388446, 39587.60412395875, 39694.80152599233, 39775.60224397755, 6809.59142451452, 6864.862702745942, 6901.689423975908, 6925.238223795379, 7546.2076481969425, 7497.587632680201, 7613.619319034054, 7656.119546252196, 7657.11943126542, 7658.9617051914665, 7639.847203055935, 7640.656170472342, 7680.385569154482, 7687.346575541086, 7701.8844717329, 7514.887276690882, 7559.28186822251, 7594.164641889388, 7627.961860190719, 7639.656215470317, 7433.702651893972, 7515.0, 7536.510126841793, 7581.052368453943, 7602.1257555380735, 36833.0, 37112.0, 37140.0, 37239.441408378894, 37243.4413483798, 3446.827658617059, 3461.273132642148, 3461.978716278704, 3481.0775144586705, 3485.2158264390564, 31210.843945780354, 31214.687853121406, 31219.063428096968, 31238.843805780827, 31379.05862824119, 5037.294778730944, 5182.611304152166, 5202.479752024805, 5224.555912747421, 5301.867453313659, 181017.0, 181059.09470452694, 181108.0, 183349.0, 184227.0, 40963.180736385104, 41513.999999999396, 47389.5261047392, 47974.0, 48395.0, 50141.74929125331, 50218.246726299134, 50595.494045059815, 50850.0, 50910.0, 14253.572392828231, 14288.42846286137, 14404.135751854923, 14509.129452232899, 14516.491922782652, 11537.365444900612, 11591.76816463666, 11639.941800290944, 11706.531738730355, 11756.353400563052, 13577.932110339385, 13599.59201223965, 13643.249621270925, 13670.794938075936, 13741.931290343484, 5444.5916556258435, 5448.91826622601, 5568.136938774496, 5605.943940560543, 5642.689652069093, 993.9105480506789, 1003.7641154328727, 1013.3312014070679, 1014.9340292880939, 1023.8208313545249, 22536.661950070764, 22682.773172268397, 22729.659055114185, 23170.42073948131, 23177.7682223179, 1092.7927479204998, 1101.5098281264761, 1109.1899325815687, 1109.4452773613193, 1113.5768408004906, 12113.757724845455, 12260.570880019157, 12326.260424374566, 12416.441260143316, 12421.93789031049, 209284.0, 211660.0, 212116.0, 212978.0, 213017.0, 52264.0, 52301.7384913073, 52481.2127818083, 52545.211821822704, 52687.473125268254, 1359.9252041137831, 1399.3353157250428, 1422.1609250542024, 1424.0814674535075, 1435.2608406670572, 22518.662220066384, 22905.8547072649, 23069.0, 23125.306240812803, 23145.768542315036, 36656.45015324825, 36696.0, 36827.63172368242, 37043.62956370402, 37130.07174820543, 178366.0, 179083.10458447624, 181174.0, 182393.44016399165, 183009.08495457438, 30145.849270754385, 32143.678563214067, 32489.512657309686, 34168.48747268843, 34653.65346346605, 43078.13843723045, 43391.0, 43507.0, 43512.78243608762, 43625.345619815096, 31607.525887111253, 31695.207619809687, 31822.840885795424, 31939.680603193672, 31998.52002219922, 30942.0, 31035.84482077575, 31235.843820780752, 31707.365852683277, 31737.365252694355, 34830.0, 35411.46882796709, 35905.28189436145, 35927.640723593475, 36029.45955810718, 30314.242143946576, 30415.695843041285, 30550.847245763627, 31448.0, 31773.682263177074, 23858.642120368557, 23871.880640596686, 23875.0, 23878.52242955166, 24064.51870962606], "value": 16671.58796777987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1186645434078, 551.2062629813068, 560.6159780550325, 567.8466813960231, 570.1874828369573, 22170.667439988392, 22957.4260643484, 23051.0, 23074.0, 23092.07631694732, 23433.882830585822, 24079.75920240797, 24092.518149636995, 24456.0, 24506.14228502003, 6226.782062627798, 6399.584027038228, 6416.903746443807, 6419.743210271607, 6456.257530383996, 6337.651429171394, 6396.968015159918, 6414.454771344442, 6418.293987661354, 6419.844428002958, 6158.753649854, 6350.61896286222, 6374.17135772349, 6381.904271435932, 6400.263969643481, 6354.046892966069, 6359.20509936258, 6372.171617689717, 6395.584287021329, 6403.327650596691, 5913.526917846562, 5937.940620593782, 5942.405759424067, 5950.256217972754, 5959.940400595982, 27188.728112718818, 27520.311992200153, 27549.86225068882, 27621.447571048466, 27647.58528622052, 2012.2152360579387, 2019.8586098973078, 2021.242034237161, 2030.8172264496118, 2042.4995876010323, 17782.91108544462, 18599.44201673952, 18602.34891778795, 18617.813821861742, 18641.7203741944, 2351.1183306260154, 2368.3250273672093, 2379.6311571706415, 2380.6310021946624, 2380.964285535701, 116498.0, 121325.0, 123262.0, 128354.0, 129181.70818291791, 14370.497032604018, 14464.855351446562, 14526.273686315642, 14546.854531454761, 14806.851931480764, 22094.779052209593, 22401.767902765503, 22435.887820561118, 22453.32640020802, 22465.77534224637, 9175.495347755937, 9351.859722104175, 9465.810683786285, 9502.239820814457, 9511.524423778783, 8545.829083418297, 8683.609237584198, 8735.868961965576, 8815.603297851612, 8821.911780882238, 8552.358573107042, 8736.985739919717, 8766.298696104424, 8856.848609680701, 8930.50882201472, 2532.645429639852, 2571.515596366896, 2591.209681047261, 2596.9610455843176, 2704.148193319098, 942.3356533643764, 953.3850666320185, 965.8020105878278, 966.7565318356952, 970.6263088710756, 18823.71764423535, 19066.428007159808, 19082.33211837579, 19092.045397730057, 19520.804791951898, 993.7068564773409, 1004.2417974429259, 1006.1900170362782, 1008.7578981044496, 1009.3741880034426, 10354.689359319233, 10492.16062714981, 10595.84106238407, 10617.628383006559, 10846.566137354417, 468290.0, 471021.0, 476702.0, 480280.0, 485238.0, 103690.48154759179, 105471.47264263629, 106469.46765266125, 106875.0, 107074.0, 1100.944952752359, 1103.8730545987153, 1127.8984891359817, 1129.9774004519863, 1131.8342107629155, 16696.248668810174, 16717.331306747594, 16763.748543772097, 16783.832161678227, 16832.663346733243, 53856.73071634617, 54574.45425545853, 54975.72512137414, 55667.0, 55779.0, 67086.32913670996, 67211.66394168194, 67408.6629566849, 67940.0, 68127.63744725176, 13803.723925521634, 13926.51257205993, 13984.930075349965, 14055.297235138407, 14084.15495070299, 21325.6801147986, 21357.14571417126, 21371.358859233627, 21593.568128637653, 21700.45748856291, 17220.569485762957, 17336.39322623702, 17387.217575209397, 17534.473965781046, 17582.560435989202, 15495.225238738243, 15563.45527906563, 15941.644960178515, 16301.347946082024, 16482.25829837684, 18074.825136366093, 18261.726074108632, 18307.450776476726, 18391.0, 18400.89594624327, 13783.931080344935, 13801.930990344985, 13810.585682429542, 13823.447062117804, 13848.723025539633, 17223.397181099102, 17292.0, 17392.0, 17533.912330438267, 17565.12174391301], "value": 11471.12643700477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.2028352563173, 1371.9999999999998, 1389.9513517026905, 1403.3754979034327, 1404.5996890886092, 14785.26073696315, 15356.69286614267, 15364.0, 15367.0, 15392.769108463383, 15047.24763761813, 15051.62370940727, 15090.924545377258, 15176.84823151768, 15201.0, 2695.7439043290956, 2720.483108209439, 2759.4205216904375, 2762.1713485954233, 2762.337039110619, 2711.3221694576355, 2713.091114476643, 2713.4437440324787, 2714.796390270728, 2715.7827373810146, 2604.830686005413, 2615.4115324052127, 2616.28052285622, 2637.0243010086297, 2648.4570663014038, 2470.197185914576, 2526.570483017882, 2532.240327901622, 2536.087008676884, 2545.5927051671642, 2428.4171798768343, 2428.659987601737, 2430.7083150021936, 2431.501542183848, 2435.683361163055, 14186.432542698383, 14370.712585748226, 14389.280535973265, 14415.639609009753, 14426.783598246035, 7710.0, 7978.800529986739, 7991.361770836965, 8006.759797206093, 8022.27799498048, 4913.975430122862, 4967.677100988461, 4979.775910084055, 5086.287919691246, 5232.8691782705355, 1915.808419158087, 1929.7394851694983, 1935.525796179931, 1943.9611207775765, 1979.356709069558, 23551.528969420688, 23804.642930356058, 24045.87977060121, 25306.1142859999, 25573.616395754078, 6950.235474097845, 7092.6289313100415, 7185.568865868065, 7219.526685810414, 7241.2396698346965, 19820.108095135754, 19823.207071717257, 19859.503512412306, 19926.900365498368, 20063.498412539804, 7663.9616801916745, 7734.5359278443475, 7794.493357931717, 8054.395920305883, 8071.4349995500925, 7028.683709233097, 7200.603966781878, 7401.037865077506, 7429.07136607924, 7433.628318584049, 5261.447548007404, 5398.0, 5429.972850135724, 5450.127979523258, 5550.5282051026115, 1694.788151481065, 1731.1690388613536, 1740.443058221357, 1752.3253547384095, 1784.9018303993146, 859.4327743689136, 877.0834477970536, 894.5884892949186, 896.852019416789, 899.2086963472234, 7629.618519074135, 7691.346235569928, 7714.267144621252, 7782.922170778333, 7927.841443171104, 692.941100006495, 693.569986608296, 694.8436601764664, 699.9335063168991, 700.4816435837444, 4226.4716910386205, 4238.158380108277, 4244.0026593750445, 4255.489341279066, 4286.678499112579, 20122.0, 21179.788202117783, 21192.470188245108, 21437.464063398227, 21469.78530214709, 19912.60174796496, 20490.487737806376, 21106.0, 21136.365909022756, 21194.894025529775, 10247.538860751283, 10410.68767936963, 10424.322419042737, 10485.475726213659, 10609.310394824312, 7878.606069696607, 8044.074931382732, 8119.959400202961, 8177.918220817715, 8280.958595207227, 17212.569685757957, 17875.46373608794, 17927.0, 17972.82027179764, 18149.455516334532, 18026.81973180304, 18041.1881465337, 18155.0, 18741.250349985847, 19235.0, 10961.83557246626, 11448.82826757616, 11546.94226528862, 11574.305541667527, 11620.418979050844, 13519.797203042159, 13671.521496747566, 13690.93154534221, 13711.794323084961, 13738.381772820047, 10617.0, 10816.4050977197, 10947.671569852917, 10950.34297942126, 11078.612248571262, 10666.73333166677, 10693.0752464554, 10706.197035222545, 10777.568897244022, 10789.1368690503, 9275.953620232125, 9394.624215031323, 9450.291228158054, 9476.668316608886, 9577.760555986157, 6845.110135682528, 6900.896486552806, 6921.584704917721, 6966.0, 6997.930020699931, 6799.048133261248, 6910.308969103049, 6923.9653801730665, 6946.0970073892095, 7046.907729301966], "value": 6477.45379667821, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.90018546198036, 497.43292646383117, 506.9366329208848, 507.4139369028773, 519.5350161605363, 6204.627722336663, 6218.37816218378, 6220.751169953202, 6255.687215639211, 6262.248530176385, 6059.454649081582, 6111.969440152793, 6148.1392605035335, 6155.599886007418, 6192.934497423782, 5093.0, 5097.3118628984985, 5102.948970510284, 5108.591312694975, 5129.846104616868, 5063.480955713289, 5121.897562048757, 5136.717480538568, 5144.09978253806, 5166.199239117943, 4773.594244489223, 4894.119058569456, 4920.70475771453, 4920.9911968046645, 5040.924386134211, 4811.615070794363, 4853.417589889236, 4904.656674032819, 4931.753412329387, 4959.727215003173, 4260.914781704349, 4376.978115109436, 4400.383946247528, 4401.603855653007, 4429.844955426544, 6004.729787159545, 6013.188219590343, 6028.7588496460085, 6035.456808887221, 6076.513878889678, 5560.49866536033, 5569.554435645138, 5606.6636001840025, 5646.265985421869, 5657.688827114507, 6459.289478157399, 6490.0, 6496.285408605049, 6498.415142637185, 6502.837429064264, 4513.487981526193, 4788.209945359012, 4790.473047964721, 4793.664443488957, 4805.5434733700595, 6558.639274839882, 6671.833204169886, 6707.765228216989, 6745.2580216176675, 6787.423069039138, 4767.570918617341, 4807.375041244616, 4840.806367745321, 4845.370101886732, 4849.854504364875, 4874.561289483963, 4884.705553028451, 4897.216445368724, 4909.950900491021, 4944.739091531636, 5458.208559758813, 5478.643888147338, 5528.253685752452, 5539.695316757617, 5598.552115830724, 6444.709988050456, 6539.378759017885, 6547.0, 6550.868982620416, 6560.573562718408, 1673.6652669466155, 1686.1316422042657, 1711.880168388201, 1715.0, 1720.1829131162847, 1131.3947038334452, 1160.7985734764648, 1161.8903946730852, 1183.5620820296544, 1190.0776897904193, 5587.413321601254, 5596.2165296858475, 5601.215829783833, 5624.3813180550105, 5636.408177141423, 6628.171478565179, 6638.705452436825, 6640.169978752656, 6654.900176497356, 6709.329067093252, 5560.138178582326, 5569.66582005081, 5593.664380137205, 5625.774969001194, 5647.548196144298, 3482.4776283557667, 3484.930301393958, 3509.2104276538084, 3540.2742437800703, 3542.6634469725336, 6153.7230824613, 6235.625862448268, 6274.592151510137, 6306.400891915261, 6359.523035772243, 6552.246491653425, 6685.53201275906, 6731.360520750521, 6799.218089919624, 6819.522633415613, 6240.875182496416, 6253.624782513064, 6303.149074874925, 6334.208223972004, 6345.96827015862, 6464.868647986489, 6523.510736694672, 6565.507586931095, 6569.977810207358, 6620.933790662032, 6393.936060639334, 6464.353564643498, 6485.254195767358, 6510.5117116217425, 6529.281779004401, 5714.9142762857755, 6212.4408803207925, 6225.564210505221, 6233.563650544418, 6261.373862613702, 4809.302651115639, 4810.735409552508, 4814.422269327703, 4827.782749776339, 4849.393825771778, 6220.564560480904, 6442.613443193236, 6527.967360163168, 6561.934380656132, 6676.0987266718375, 6249.96875015622, 6301.282243476371, 6314.147590075281, 6363.427291543783, 6462.676866156768, 6313.684315784284, 6390.520710946605, 6424.0, 6482.57863238888, 6496.9025464617125, 6339.683015849281, 6351.555391122577, 6397.96801015992, 6428.55000149985, 6443.548951573345, 6478.838029049311, 6500.479961602966, 6512.73949042033, 6565.540412171294, 6567.802965911031, 6257.812265632038, 6262.655553944577, 6307.526935479766, 6326.367363263821, 6331.398517140864], "value": 4955.5769932581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.9496630202186, 853.2193043365321, 858.223307906345, 861.7974775927657, 865.3596338709357, 15923.442679506219, 16149.596260093504, 16464.341426342933, 16480.917595412022, 16538.83461165388, 15799.684006319867, 16280.511584652479, 16372.690184785219, 16452.259648315823, 16456.506304810875, 923.6166990698852, 942.1002942190227, 942.3968660057569, 942.8491441369348, 944.9338546301761, 922.796984663373, 924.8612708093773, 925.0240995749482, 934.2105920497169, 965.377331621104, 1011.2163073617932, 1021.1830535571551, 1034.105498743585, 1034.493098381795, 1035.7203555040135, 1021.2748948246754, 1022.4785359466688, 1029.2332212501733, 1031.6234574380296, 1032.9690109296732, 712.779038498062, 726.7165805335924, 727.1855521815547, 728.144430294402, 732.0300601702712, 16653.583660408465, 16833.91583042089, 16888.915555422267, 16897.91551042237, 16993.150342482826, 20913.581728365498, 20999.89500052505, 21315.25396611111, 21468.5706285875, 21593.136274549, 16837.663246734995, 16878.071706056162, 16918.492445226664, 17074.573135671584, 17200.741988870177, 3330.0509354834, 3366.4445366514497, 3373.645767194458, 3378.746594005435, 3382.6109997350372, 136556.0, 138602.3069884644, 139366.0, 142071.2896435511, 142999.0, 16274.349026038826, 16394.0, 16414.015159090493, 16803.747943780854, 16830.15849207535, 31059.534106988413, 31504.212394690316, 31673.8416307917, 31738.36523269568, 32384.0, 7651.923480765233, 7746.612669366509, 7768.067831860213, 7788.532688038736, 7797.0, 4026.074002979331, 4059.8579049733116, 4094.4267802507675, 4098.139390727981, 4133.379993001014, 5239.921401178985, 5278.155495120839, 5293.602979776532, 5349.625526213205, 5390.21841832932, 852.4953457148139, 853.5945425922637, 873.7466134820958, 875.1817051057282, 879.3932186791094, 644.2526669063864, 647.4529022975578, 656.2158220926043, 670.1054092786088, 672.042339665974, 10774.24580279373, 10873.184511161695, 11183.72040698989, 11387.373694446886, 11955.88044119565, 636.8694417644465, 644.490852226745, 647.782169521297, 659.4361820643377, 665.125360151409, 5323.707196104251, 5434.565234781208, 5575.749091290902, 5591.720413979366, 5648.265725455664, 119188.40405797916, 123081.38459307826, 123277.38361308136, 123427.0, 128989.35505322414, 99574.50212749034, 104389.0, 107306.0, 109044.0, 111002.0, 91797.0, 92525.0, 94512.0, 94856.0, 94906.52546737222, 9655.565499552396, 9753.853692194765, 9766.414015159113, 9879.753006174904, 10009.999000099931, 42785.0, 43060.56939430691, 44467.55532444763, 44691.776541117084, 45589.0, 57285.42714572801, 57935.0, 58568.0, 58982.0, 59109.704451479185, 13924.955628327712, 14409.13545187292, 14584.781228281796, 14839.40642374293, 14850.702985940005, 17461.30154793794, 17536.298548057934, 17652.20565074549, 17684.557886052953, 17903.820961790738, 14289.71420571562, 14428.927855361077, 14474.203918784568, 14479.565613031626, 14691.926540367229, 14978.400863965755, 15093.47172848945, 15118.773218401513, 15233.314500847267, 15543.145127018122, 15447.150406727738, 15636.218189090272, 15686.764698529303, 15740.0, 15807.762883556527, 10755.516001780095, 10934.507947142556, 11003.779924401628, 11303.1522635801, 11352.148588855704, 10592.682219533426, 10594.205434592282, 10758.300710453796, 10764.784704306026, 11030.22788404804], "value": 8503.267193991736, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 116.0, 114.0, 110.0, 115.0, 108.0, 107.0, 107.0, 107.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 115.0, 147.0, 123.0, 119.0, 123.0, 122.0, 116.0, 117.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 166.0, 170.0, 172.0, 171.0, 164.0, 165.0, 167.0, 177.0], "value": 169.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 75.0, 85.0, 82.0, 77.0, 77.0, 84.0, 76.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 79.0, 82.0, 80.0, 87.0, 79.0, 83.0, 85.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 125.0, 117.0, 123.0, 114.0, 117.0, 114.0, 127.0, 116.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 158.0, 147.0, 149.0, 150.0, 149.0, 150.0, 149.0, 148.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 94.0, 94.0, 101.0, 95.0, 100.0, 97.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 55.0, 56.0, 57.0, 65.0, 52.0, 53.0, 53.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 43.0, 47.0, 38.0, 42.0, 44.0, 47.0, 41.0, 38.0, 46.0], "value": 42.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 76.0, 80.0, 76.0, 84.0, 77.0, 79.0, 76.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 111.0, 118.0, 123.0, 120.0, 119.0, 118.0, 113.0, 124.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 169.0, 168.0, 175.0, 168.0, 170.0, 172.0, 170.0, 169.0, 170.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 65.0, 66.0, 72.0, 66.0, 67.0, 68.0, 69.0, 66.0], "value": 67.8, "unit": "score"}]}]} 16:08:06 INFO - Return code: 0 16:08:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:06 INFO - # TBPL SUCCESS # 16:08:06 INFO - Running post-action listener: _package_coverage_data 16:08:06 INFO - Running post-action listener: _resource_record_post_action 16:08:06 INFO - [mozharness: 2017-09-11 23:08:06.406604Z] Finished run-tests step (success) 16:08:06 INFO - Running post-run listener: _resource_record_post_run 16:08:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 20135936; Write bytes: 371830784; Read time: 7000; Write time: 337236 16:08:06 INFO - TinderboxPrint: CPU usage
13.3% 16:08:06 INFO - TinderboxPrint: I/O read bytes / time
20,135,936 / 7,000 16:08:06 INFO - TinderboxPrint: I/O write bytes / time
371,830,784 / 337,236 16:08:06 INFO - TinderboxPrint: CPU idle
8,277.9 (86.7%) 16:08:06 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 16:08:06 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12718080; Read time: 0; Write time: 2808 16:08:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:08:06 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 20135936; Write bytes: 359112704; Read time: 7000; Write time: 334428 16:08:07 INFO - Running post-run listener: _upload_blobber_files 16:08:07 INFO - Blob upload gear active. 16:08:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:08:07 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'] 16:08:07 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 16:08:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:08:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:08 INFO - (blobuploader) - INFO - Done attempting. 16:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:16 INFO - (blobuploader) - INFO - Done attempting. 16:08:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:17 INFO - (blobuploader) - INFO - Done attempting. 16:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:18 INFO - (blobuploader) - INFO - Done attempting. 16:08:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:18 INFO - Return code: 0 16:08:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c583eedc16458f6cd8576c6b805062bdd80ac74abfa7823f7bb20b17685454bfedb2570de4fa52fcebf9499d8fa4d341e225c29545e2192f3d24a8b4f6660d0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84dedbac169cf456e3d679bca3fbab6279118e5276b341fb61dd69f6e8cbe3ef6488fc57db9cc4642151201396859dd01d7b17a38d4a03b8633c2addc58b29e5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeded3dceb7c3bdb3db0e1b40f86e17a7e312669b4117ad95d3bff8a2fd1da2129bb9690f6533a5af32f78af33afb3bcd6ea685106d017f618c50b2d4f678747", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fcbb4a38eecd9e4029e94e4aa091942a69eb4f6d69681e54fb85974ae6ab547f5e021e77c1f4aecda70edddc005166a298866eefb7f44b9bc8eea3845711db"} 16:08:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:18 INFO - Contents: 16:08:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c583eedc16458f6cd8576c6b805062bdd80ac74abfa7823f7bb20b17685454bfedb2570de4fa52fcebf9499d8fa4d341e225c29545e2192f3d24a8b4f6660d0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84dedbac169cf456e3d679bca3fbab6279118e5276b341fb61dd69f6e8cbe3ef6488fc57db9cc4642151201396859dd01d7b17a38d4a03b8633c2addc58b29e5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeded3dceb7c3bdb3db0e1b40f86e17a7e312669b4117ad95d3bff8a2fd1da2129bb9690f6533a5af32f78af33afb3bcd6ea685106d017f618c50b2d4f678747", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fcbb4a38eecd9e4029e94e4aa091942a69eb4f6d69681e54fb85974ae6ab547f5e021e77c1f4aecda70edddc005166a298866eefb7f44b9bc8eea3845711db"} 16:08:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:18 INFO - Copying logs to upload dir... 16:08:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.491469 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-09-11 16:08:18.247662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:18.250926) ========= 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=0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c583eedc16458f6cd8576c6b805062bdd80ac74abfa7823f7bb20b17685454bfedb2570de4fa52fcebf9499d8fa4d341e225c29545e2192f3d24a8b4f6660d0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84dedbac169cf456e3d679bca3fbab6279118e5276b341fb61dd69f6e8cbe3ef6488fc57db9cc4642151201396859dd01d7b17a38d4a03b8633c2addc58b29e5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeded3dceb7c3bdb3db0e1b40f86e17a7e312669b4117ad95d3bff8a2fd1da2129bb9690f6533a5af32f78af33afb3bcd6ea685106d017f618c50b2d4f678747", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fcbb4a38eecd9e4029e94e4aa091942a69eb4f6d69681e54fb85974ae6ab547f5e021e77c1f4aecda70edddc005166a298866eefb7f44b9bc8eea3845711db"} build_url:https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/NZL3uDQ6TNSAakTme7WydQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c583eedc16458f6cd8576c6b805062bdd80ac74abfa7823f7bb20b17685454bfedb2570de4fa52fcebf9499d8fa4d341e225c29545e2192f3d24a8b4f6660d0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84dedbac169cf456e3d679bca3fbab6279118e5276b341fb61dd69f6e8cbe3ef6488fc57db9cc4642151201396859dd01d7b17a38d4a03b8633c2addc58b29e5", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeded3dceb7c3bdb3db0e1b40f86e17a7e312669b4117ad95d3bff8a2fd1da2129bb9690f6533a5af32f78af33afb3bcd6ea685106d017f618c50b2d4f678747", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87fcbb4a38eecd9e4029e94e4aa091942a69eb4f6d69681e54fb85974ae6ab547f5e021e77c1f4aecda70edddc005166a298866eefb7f44b9bc8eea3845711db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:18.279174) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:18.279510) ========= 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=0e2a256762fed810e2f0f810000001b3-1505169654.126706-943303036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:08:18.361425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 16:08:18.361807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 16:08:18.362296) ========= ========= Total master_lag: 0.41 =========