builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1505597902.89 results: success (0) revision: 44e56a4d482a0959e00afb371872035caf3cd56d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:22.891662) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:22.892318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:22.892588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:22.917571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:22.917834) ========= 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=920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 14:38: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.37M=0.009s 2017-09-16 14:38:23 (1.37 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133528 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:23.223897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:23.227579) ========= 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=920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022237 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:23.305883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-16 14:38:23.306325) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 44e56a4d482a0959e00afb371872035caf3cd56d --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 44e56a4d482a0959e00afb371872035caf3cd56d --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=920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 14:38:23,583 truncating revision to first 12 chars 2017-09-16 14:38:23,583 Setting DEBUG logging. 2017-09-16 14:38:23,583 attempt 1/10 2017-09-16 14:38:23,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/44e56a4d482a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 14:38:24,037 attempt 1/10 2017-09-16 14:38:24,677 current task status: no status available at this point. state: STARTED 2017-09-16 14:38:24,677 sleeping for 9.00s (attempt 1/10) 2017-09-16 14:38:33,686 attempt 2/10 2017-09-16 14:38:34,095 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-16 14:38:34,291 unpacking tar archive at: mozilla-central-44e56a4d482a/testing/mozharness/ program finished with exit code 0 elapsedTime=11.039573 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-16 14:38:34.365631) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:34.365928) ========= script_repo_revision: 44e56a4d482a0959e00afb371872035caf3cd56d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:34.366302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:34.366561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 14:38:34.384312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 14:38:34.384687) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:38:34 INFO - MultiFileLogger online at 20170916 14:38:34 in /builds/slave/test 14:38:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:38:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:34 INFO - {'append_to_log': False, 14:38:34 INFO - 'base_work_dir': '/builds/slave/test', 14:38:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:38:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:34 INFO - 'branch': 'Firefox-Non-PGO', 14:38:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:34 INFO - 'code_coverage': False, 14:38:34 INFO - 'config_files': ('talos/linux_config.py',), 14:38:34 INFO - 'default_actions': ('clobber', 14:38:34 INFO - 'read-buildbot-config', 14:38:34 INFO - 'download-and-extract', 14:38:34 INFO - 'populate-webroot', 14:38:34 INFO - 'create-virtualenv', 14:38:34 INFO - 'install', 14:38:34 INFO - 'setup-mitmproxy', 14:38:34 INFO - 'run-tests'), 14:38:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:34 INFO - 'disable_ccov_upload': False, 14:38:34 INFO - 'disable_stylo': False, 14:38:34 INFO - 'download_minidump_stackwalk': True, 14:38:34 INFO - 'download_symbols': 'ondemand', 14:38:34 INFO - 'enable_stylo': False, 14:38:34 INFO - 'enable_webrender': False, 14:38:34 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:38:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:34 INFO - 'gecko_profile': False, 14:38:34 INFO - 'gecko_profile_interval': 0, 14:38:34 INFO - 'installer_path': 'installer.exe', 14:38:34 INFO - 'log_level': 'info', 14:38:34 INFO - 'log_name': 'talos', 14:38:34 INFO - 'log_to_console': True, 14:38:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:38:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:38:34 INFO - 'opt_config_files': (), 14:38:34 INFO - 'pip_index': False, 14:38:34 INFO - 'suite': 'dromaeojs-e10s', 14:38:34 INFO - 'system_bits': '32', 14:38:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:34 INFO - 'title': 'talos-linux64-ix-053', 14:38:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:34 INFO - 'use_talos_json': True, 14:38:34 INFO - 'verify': 'False', 14:38:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:34 INFO - 'work_dir': 'build'} 14:38:34 INFO - [mozharness: 2017-09-16 21:38:34.805654Z] Running clobber step. 14:38:34 INFO - Running pre-action listener: _resource_record_pre_action 14:38:34 INFO - Running main action method: clobber 14:38:34 INFO - rmtree: /builds/slave/test/build 14:38:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:35 INFO - Running post-action listener: _resource_record_post_action 14:38:35 INFO - [mozharness: 2017-09-16 21:38:35.784501Z] Finished clobber step (success) 14:38:35 INFO - [mozharness: 2017-09-16 21:38:35.784598Z] Running read-buildbot-config step. 14:38:35 INFO - Running pre-action listener: _resource_record_pre_action 14:38:35 INFO - Running main action method: read_buildbot_config 14:38:35 INFO - Using buildbot properties: 14:38:35 INFO - { 14:38:35 INFO - "project": "", 14:38:35 INFO - "product": "firefox", 14:38:35 INFO - "who": "ryanvm@gmail.com", 14:38:35 INFO - "installer_path": "public/build/target.tar.bz2", 14:38:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:38:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:38:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:38:35 INFO - "stage_platform": "linux64", 14:38:35 INFO - "basedir": "/builds/slave/test", 14:38:35 INFO - "buildnumber": 834, 14:38:35 INFO - "platform": "ubuntu64_hw", 14:38:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:38:35 INFO - "slavebuilddir": "test", 14:38:35 INFO - "taskId": "B8B5i_R3Qo-nQq04F5FqlA", 14:38:35 INFO - "branch": "mozilla-central", 14:38:35 INFO - "script_repo_revision": "production", 14:38:35 INFO - "revision": "44e56a4d482a0959e00afb371872035caf3cd56d", 14:38:35 INFO - "slavename": "talos-linux64-ix-053", 14:38:35 INFO - "repo_path": "mozilla-central" 14:38:35 INFO - } 14:38:35 INFO - Finding installer, test and symbols from parent task. 14:38:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8B5i_R3Qo-nQq04F5FqlA'}, attempt #1 14:38:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8B5i_R3Qo-nQq04F5FqlA'}, attempt #1 14:38:36 INFO - Task dependencies: Tz2ed14HQ4ehJhdTJ9h8Sg 14:38:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg'}, attempt #1 14:38:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2 14:38:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.test_packages.json 14:38:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.crashreporter-symbols.zip 14:38:37 INFO - Running post-action listener: _resource_record_post_action 14:38:37 INFO - [mozharness: 2017-09-16 21:38:37.155159Z] Finished read-buildbot-config step (success) 14:38:37 INFO - [mozharness: 2017-09-16 21:38:37.155374Z] Running download-and-extract step. 14:38:37 INFO - Running pre-action listener: _resource_record_pre_action 14:38:37 INFO - Running main action method: download_and_extract 14:38:37 INFO - mkdir: /builds/slave/test/build/tests 14:38:37 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')]} 14:38:37 INFO - trying https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.test_packages.json 14:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:38:37 INFO - Downloaded 989 bytes. 14:38:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:38:37 INFO - Using the following test package requirements: 14:38:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:38:37 INFO - u'common': [u'target.common.tests.zip'], 14:38:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:38:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:38:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:38:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:38:37 INFO - u'mozbase': [u'target.common.tests.zip'], 14:38:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:38:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:38:37 INFO - u'web-platform': [u'target.common.tests.zip', 14:38:37 INFO - u'target.web-platform.tests.tar.gz'], 14:38:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:38:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:38:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.common.tests.zip 14:38:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:38:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.common.tests.zip into memory 14:38:39 INFO - Content-Length response header: 54731289 14:38:39 INFO - Bytes received: 54731289 14:38:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.talos.tests.zip 14:38:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:38:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.talos.tests.zip into memory 14:38:51 INFO - Content-Length response header: 14508748 14:38:51 INFO - Bytes received: 14508748 14:38: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')]} 14:38:51 INFO - trying https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2 14:38:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:38:55 INFO - Downloaded 61351489 bytes. 14:38:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2 14:38:55 INFO - mkdir: /builds/slave/test/properties 14:38:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:38:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:38:55 INFO - Contents: 14:38:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2 14:38:55 INFO - Running post-action listener: _resource_record_post_action 14:38:55 INFO - Running post-action listener: find_tests_for_verification 14:38:55 INFO - Running post-action listener: set_extra_try_arguments 14:38:55 INFO - [mozharness: 2017-09-16 21:38:55.202591Z] Finished download-and-extract step (success) 14:38:55 INFO - [mozharness: 2017-09-16 21:38:55.202818Z] Running populate-webroot step. 14:38:55 INFO - Running pre-action listener: _resource_record_pre_action 14:38:55 INFO - Running main action method: populate_webroot 14:38:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:38:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['tresize', 14:38:55 INFO - 'tcanvasmark']}, 14:38:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:38:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['dromaeo_css', 14:38:55 INFO - 'kraken']}, 14:38:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'tests': ['damp', 'tps']}, 14:38:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['damp', 'tps']}, 14:38:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:38:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['dromaeo_dom']}, 14:38:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:38:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['basic_compositor_video', 14:38:55 INFO - 'glvideo']}, 14:38:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:38:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['ts_paint_webext', 14:38:55 INFO - 'tp5o_webext']}, 14:38:55 INFO - 'other-e10s': {'tests': ['a11yr', 14:38:55 INFO - 'ts_paint', 14:38:55 INFO - 'tpaint', 14:38:55 INFO - 'sessionrestore', 14:38:55 INFO - 'sessionrestore_many_windows', 14:38:55 INFO - 'sessionrestore_no_auto_restore', 14:38:55 INFO - 'tabpaint']}, 14:38:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['a11yr', 14:38:55 INFO - 'ts_paint', 14:38:55 INFO - 'tpaint', 14:38:55 INFO - 'sessionrestore', 14:38:55 INFO - 'sessionrestore_many_windows', 14:38:55 INFO - 'sessionrestore_no_auto_restore', 14:38:55 INFO - 'tabpaint']}, 14:38:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:38:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:38:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['perf_reftest_singletons']}, 14:38:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['bloom_basic']}, 14:38:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:38:55 INFO - 'tsvgr_opacity', 14:38:55 INFO - 'tart', 14:38:55 INFO - 'tscrollx', 14:38:55 INFO - 'tsvg_static']}, 14:38:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['tsvgx', 14:38:55 INFO - 'tsvgr_opacity', 14:38:55 INFO - 'tart', 14:38:55 INFO - 'tscrollx', 14:38:55 INFO - 'tsvg_static']}, 14:38:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:38:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'talos_options': ['--disable-stylo'], 14:38:55 INFO - 'tests': ['tp5o']}, 14:38:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:38:55 INFO - 'talos_options': ['--mitmproxy', 14:38:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:38:55 INFO - '--firstNonBlankPaint'], 14:38:55 INFO - 'tests': ['tp6_google', 14:38:55 INFO - 'tp6_youtube', 14:38:55 INFO - 'tp6_amazon', 14:38:55 INFO - 'tp6_facebook']}, 14:38:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:38:55 INFO - 'talos_options': ['--disable-stylo', 14:38:55 INFO - '--mitmproxy', 14:38:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:38:55 INFO - '--firstNonBlankPaint'], 14:38:55 INFO - 'tests': ['tp6_google', 14:38:55 INFO - 'tp6_youtube', 14:38:55 INFO - 'tp6_amazon', 14:38:55 INFO - 'tp6_facebook']}, 14:38:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:38:55 INFO - 'talos_options': ['--stylo-threads=1', 14:38:55 INFO - '--mitmproxy', 14:38:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:38:55 INFO - '--firstNonBlankPaint'], 14:38:55 INFO - 'tests': ['tp6_google', 14:38:55 INFO - 'tp6_youtube', 14:38:55 INFO - 'tp6_amazon', 14:38:55 INFO - 'tp6_facebook']}, 14:38:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'talos_options': ['--xperf_path', 14:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:55 INFO - 'tests': ['tp5n']}, 14:38:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:38:55 INFO - 'talos_options': ['--disable-stylo', 14:38:55 INFO - '--xperf_path', 14:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:55 INFO - 'tests': ['tp5n']}}} 14:38:55 INFO - Running post-action listener: _resource_record_post_action 14:38:55 INFO - [mozharness: 2017-09-16 21:38:55.218308Z] Finished populate-webroot step (success) 14:38:55 INFO - [mozharness: 2017-09-16 21:38:55.218397Z] Running create-virtualenv step. 14:38:55 INFO - Running pre-action listener: _resource_record_pre_action 14:38:55 INFO - Running main action method: create_virtualenv 14:38:55 INFO - Creating virtualenv /builds/slave/test/build/venv 14:38:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:38:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:38:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:38:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:38:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:38:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:38:56 INFO - Installing pip...............done. 14:38:56 INFO - Return code: 0 14:38:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:38:56 INFO - Reading from file tmpfile_stdout 14:38:56 INFO - Output received: 14:38:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:38:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:38:56 INFO - Using env: {'DISPLAY': ':0', 14:38:56 INFO - 'HOME': '/home/cltbld', 14:38:56 INFO - 'LANG': 'en_US.UTF-8', 14:38:56 INFO - 'LANGUAGE': 'en_US:en', 14:38:56 INFO - 'LOGNAME': 'cltbld', 14:38:56 INFO - 'MAIL': '/var/mail/cltbld', 14:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:56 INFO - 'MOZ_NO_REMOTE': '1', 14:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:56 INFO - 'NO_EM_RESTART': '1', 14:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:56 INFO - 'PWD': '/builds/slave/test', 14:38:56 INFO - 'SHELL': '/bin/bash', 14:38:56 INFO - 'SHLVL': '1', 14:38:56 INFO - 'TERM': 'linux', 14:38:56 INFO - 'TMOUT': '86400', 14:38:56 INFO - 'USER': 'cltbld', 14:38:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:56 INFO - '_': '/tools/buildbot/bin/python'} 14:38:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:38:57 INFO - Downloading/unpacking pip>=1.5 14:38:57 INFO - Running setup.py egg_info for package pip 14:38:57 INFO - warning: no files found matching 'pip/cacert.pem' 14:38:57 INFO - warning: no files found matching '*.html' under directory 'docs' 14:38:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:38:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:38:57 INFO - Installing collected packages: pip 14:38:57 INFO - Found existing installation: pip 1.1 14:38:57 INFO - Uninstalling pip: 14:38:57 INFO - Successfully uninstalled pip 14:38:57 INFO - Running setup.py install for pip 14:38:57 INFO - warning: no files found matching 'pip/cacert.pem' 14:38:57 INFO - warning: no files found matching '*.html' under directory 'docs' 14:38:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:38:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:38:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:38:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:38:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:38:57 INFO - Successfully installed pip 14:38:57 INFO - Cleaning up... 14:38:57 INFO - Return code: 0 14:38:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:38: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')]} 14:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38: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')]} 14:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:57 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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:38:57 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 14:38:57 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 14:38:57 INFO - Using env: {'DISPLAY': ':0', 14:38:57 INFO - 'HOME': '/home/cltbld', 14:38:57 INFO - 'LANG': 'en_US.UTF-8', 14:38:57 INFO - 'LANGUAGE': 'en_US:en', 14:38:57 INFO - 'LOGNAME': 'cltbld', 14:38:57 INFO - 'MAIL': '/var/mail/cltbld', 14:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:57 INFO - 'MOZ_NO_REMOTE': '1', 14:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:57 INFO - 'NO_EM_RESTART': '1', 14:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:57 INFO - 'PWD': '/builds/slave/test', 14:38:57 INFO - 'SHELL': '/bin/bash', 14:38:57 INFO - 'SHLVL': '1', 14:38:57 INFO - 'TERM': 'linux', 14:38:57 INFO - 'TMOUT': '86400', 14:38:57 INFO - 'USER': 'cltbld', 14:38:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:57 INFO - '_': '/tools/buildbot/bin/python'} 14:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:57 INFO - Downloading/unpacking psutil>=3.1.1 14:38:57 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 14:38:57 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 14:38:57 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 14:38:57 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 14:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:38:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:58 INFO - Installing collected packages: psutil 14:38:58 INFO - Running setup.py install for psutil 14:38:58 INFO - building 'psutil._psutil_linux' extension 14:38:58 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 14:38:59 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 14:38:59 INFO - building 'psutil._psutil_posix' extension 14:38:59 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 14:38:59 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 14:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:59 INFO - Successfully installed psutil 14:38:59 INFO - Cleaning up... 14:38:59 INFO - Return code: 0 14:38:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:38:59 INFO - Using env: {'DISPLAY': ':0', 14:38:59 INFO - 'HOME': '/home/cltbld', 14:38:59 INFO - 'LANG': 'en_US.UTF-8', 14:38:59 INFO - 'LANGUAGE': 'en_US:en', 14:38:59 INFO - 'LOGNAME': 'cltbld', 14:38:59 INFO - 'MAIL': '/var/mail/cltbld', 14:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:59 INFO - 'MOZ_NO_REMOTE': '1', 14:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:59 INFO - 'NO_EM_RESTART': '1', 14:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:59 INFO - 'PWD': '/builds/slave/test', 14:38:59 INFO - 'SHELL': '/bin/bash', 14:38:59 INFO - 'SHLVL': '1', 14:38:59 INFO - 'TERM': 'linux', 14:38:59 INFO - 'TMOUT': '86400', 14:38:59 INFO - 'USER': 'cltbld', 14:38:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:59 INFO - '_': '/tools/buildbot/bin/python'} 14:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:39:01 INFO - Installing collected packages: mozsystemmonitor 14:39:01 INFO - Running setup.py install for mozsystemmonitor 14:39:01 INFO - Successfully installed mozsystemmonitor 14:39:01 INFO - Cleaning up... 14:39:01 INFO - Return code: 0 14:39:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:39:01 INFO - Using env: {'DISPLAY': ':0', 14:39:01 INFO - 'HOME': '/home/cltbld', 14:39:01 INFO - 'LANG': 'en_US.UTF-8', 14:39:01 INFO - 'LANGUAGE': 'en_US:en', 14:39:01 INFO - 'LOGNAME': 'cltbld', 14:39:01 INFO - 'MAIL': '/var/mail/cltbld', 14:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:01 INFO - 'MOZ_NO_REMOTE': '1', 14:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:01 INFO - 'NO_EM_RESTART': '1', 14:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:01 INFO - 'PWD': '/builds/slave/test', 14:39:01 INFO - 'SHELL': '/bin/bash', 14:39:01 INFO - 'SHLVL': '1', 14:39:01 INFO - 'TERM': 'linux', 14:39:01 INFO - 'TMOUT': '86400', 14:39:01 INFO - 'USER': 'cltbld', 14:39:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:01 INFO - '_': '/tools/buildbot/bin/python'} 14:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:01 INFO - Downloading/unpacking jsonschema==2.5.1 14:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:39: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 14:39: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 14:39: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 14:39: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 14:39:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:02 INFO - warning: no files found matching '*.txt' 14:39:02 INFO - no previously-included directories found matching 'build' 14:39:02 INFO - no previously-included directories found matching 'dist' 14:39:02 INFO - no previously-included directories found matching '.git*' 14:39:02 INFO - Installing collected packages: jsonschema, functools32 14:39:02 INFO - Running setup.py install for functools32 14:39:02 INFO - warning: no files found matching '*.txt' 14:39:02 INFO - no previously-included directories found matching 'build' 14:39:02 INFO - no previously-included directories found matching 'dist' 14:39:02 INFO - no previously-included directories found matching '.git*' 14:39:02 INFO - Successfully installed jsonschema functools32 14:39:02 INFO - Cleaning up... 14:39:03 INFO - Return code: 0 14:39:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:39:03 INFO - Using env: {'DISPLAY': ':0', 14:39:03 INFO - 'HOME': '/home/cltbld', 14:39:03 INFO - 'LANG': 'en_US.UTF-8', 14:39:03 INFO - 'LANGUAGE': 'en_US:en', 14:39:03 INFO - 'LOGNAME': 'cltbld', 14:39:03 INFO - 'MAIL': '/var/mail/cltbld', 14:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:03 INFO - 'MOZ_NO_REMOTE': '1', 14:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:03 INFO - 'NO_EM_RESTART': '1', 14:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:03 INFO - 'PWD': '/builds/slave/test', 14:39:03 INFO - 'SHELL': '/bin/bash', 14:39:03 INFO - 'SHLVL': '1', 14:39:03 INFO - 'TERM': 'linux', 14:39:03 INFO - 'TMOUT': '86400', 14:39:03 INFO - 'USER': 'cltbld', 14:39:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:03 INFO - '_': '/tools/buildbot/bin/python'} 14:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:39:03 INFO - Cleaning up... 14:39:03 INFO - Return code: 0 14:39:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:39:03 INFO - Using env: {'DISPLAY': ':0', 14:39:03 INFO - 'HOME': '/home/cltbld', 14:39:03 INFO - 'LANG': 'en_US.UTF-8', 14:39:03 INFO - 'LANGUAGE': 'en_US:en', 14:39:03 INFO - 'LOGNAME': 'cltbld', 14:39:03 INFO - 'MAIL': '/var/mail/cltbld', 14:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:03 INFO - 'MOZ_NO_REMOTE': '1', 14:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:03 INFO - 'NO_EM_RESTART': '1', 14:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:03 INFO - 'PWD': '/builds/slave/test', 14:39:03 INFO - 'SHELL': '/bin/bash', 14:39:03 INFO - 'SHLVL': '1', 14:39:03 INFO - 'TERM': 'linux', 14:39:03 INFO - 'TMOUT': '86400', 14:39:03 INFO - 'USER': 'cltbld', 14:39:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:03 INFO - '_': '/tools/buildbot/bin/python'} 14:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39: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 14:39: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 14:39: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 14:39: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 14:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:06 INFO - Downloading docopt-0.6.1.tar.gz 14:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:06 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:06 INFO - Running setup.py install for blobuploader 14:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:06 INFO - Running setup.py install for requests 14:39:06 INFO - Running setup.py install for docopt 14:39:06 INFO - Successfully installed blobuploader requests docopt 14:39:06 INFO - Cleaning up... 14:39:06 INFO - Return code: 0 14:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:06 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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:06 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 14:39:06 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 14:39:06 INFO - Using env: {'DISPLAY': ':0', 14:39:06 INFO - 'HOME': '/home/cltbld', 14:39:06 INFO - 'LANG': 'en_US.UTF-8', 14:39:06 INFO - 'LANGUAGE': 'en_US:en', 14:39:06 INFO - 'LOGNAME': 'cltbld', 14:39:06 INFO - 'MAIL': '/var/mail/cltbld', 14:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:06 INFO - 'MOZ_NO_REMOTE': '1', 14:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:06 INFO - 'NO_EM_RESTART': '1', 14:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:06 INFO - 'PWD': '/builds/slave/test', 14:39:06 INFO - 'SHELL': '/bin/bash', 14:39:06 INFO - 'SHLVL': '1', 14:39:06 INFO - 'TERM': 'linux', 14:39:06 INFO - 'TMOUT': '86400', 14:39:06 INFO - 'USER': 'cltbld', 14:39:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:06 INFO - '_': '/tools/buildbot/bin/python'} 14:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:07 INFO - Running setup.py (path:/tmp/pip-oHRTgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:07 INFO - Running setup.py (path:/tmp/pip-3kvxAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:07 INFO - Running setup.py (path:/tmp/pip-Bw5mwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:07 INFO - Running setup.py (path:/tmp/pip-OsBN4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:07 INFO - Running setup.py (path:/tmp/pip-LgbUf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:07 INFO - Running setup.py (path:/tmp/pip-ettslo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:07 INFO - Running setup.py (path:/tmp/pip-Oq5PmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:07 INFO - Running setup.py (path:/tmp/pip-d4ekKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:07 INFO - Running setup.py (path:/tmp/pip-ooqsbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:07 INFO - Running setup.py (path:/tmp/pip-ZlUy6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:07 INFO - Running setup.py (path:/tmp/pip-GxRFwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:07 INFO - Running setup.py (path:/tmp/pip-SccoNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:08 INFO - Running setup.py (path:/tmp/pip-wLvqZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:08 INFO - Running setup.py (path:/tmp/pip-3Iup3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:08 INFO - Running setup.py (path:/tmp/pip-gIqfMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:08 INFO - Running setup.py (path:/tmp/pip-n4oDCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:08 INFO - Running setup.py (path:/tmp/pip-NvQMVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:08 INFO - Running setup.py install for manifestparser 14:39:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:08 INFO - Running setup.py install for mozcrash 14:39:08 INFO - Running setup.py install for mozdebug 14:39:08 INFO - Running setup.py install for mozdevice 14:39:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:08 INFO - Running setup.py install for mozfile 14:39:08 INFO - Running setup.py install for mozhttpd 14:39:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:08 INFO - Running setup.py install for mozinfo 14:39:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Running setup.py install for mozInstall 14:39:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Running setup.py install for mozleak 14:39:09 INFO - Running setup.py install for mozlog 14:39:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Running setup.py install for moznetwork 14:39:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Running setup.py install for mozprocess 14:39:09 INFO - Running setup.py install for mozprofile 14:39:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Running setup.py install for mozrunner 14:39:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:09 INFO - Running setup.py install for mozscreenshot 14:39:09 INFO - Running setup.py install for moztest 14:39:10 INFO - Running setup.py install for mozversion 14:39:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:10 INFO - Cleaning up... 14:39:10 INFO - Return code: 0 14:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:10 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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:10 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 14:39:10 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 14:39:10 INFO - Using env: {'DISPLAY': ':0', 14:39:10 INFO - 'HOME': '/home/cltbld', 14:39:10 INFO - 'LANG': 'en_US.UTF-8', 14:39:10 INFO - 'LANGUAGE': 'en_US:en', 14:39:10 INFO - 'LOGNAME': 'cltbld', 14:39:10 INFO - 'MAIL': '/var/mail/cltbld', 14:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:10 INFO - 'MOZ_NO_REMOTE': '1', 14:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:10 INFO - 'NO_EM_RESTART': '1', 14:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:10 INFO - 'PWD': '/builds/slave/test', 14:39:10 INFO - 'SHELL': '/bin/bash', 14:39:10 INFO - 'SHLVL': '1', 14:39:10 INFO - 'TERM': 'linux', 14:39:10 INFO - 'TMOUT': '86400', 14:39:10 INFO - 'USER': 'cltbld', 14:39:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:10 INFO - '_': '/tools/buildbot/bin/python'} 14:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:10 INFO - Running setup.py (path:/tmp/pip-t_Smxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:10 INFO - Running setup.py (path:/tmp/pip-7F9V1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:10 INFO - Running setup.py (path:/tmp/pip-hm5rWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:10 INFO - Running setup.py (path:/tmp/pip-Yvyz09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:10 INFO - Running setup.py (path:/tmp/pip-ZVKhAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:10 INFO - Running setup.py (path:/tmp/pip-1AmYOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:10 INFO - Running setup.py (path:/tmp/pip-XxmJ7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:10 INFO - Running setup.py (path:/tmp/pip-ipYSfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:10 INFO - Running setup.py (path:/tmp/pip-rWvni2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:10 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)) 14:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:10 INFO - Running setup.py (path:/tmp/pip-ViUkCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:11 INFO - Running setup.py (path:/tmp/pip-tCNrg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:11 INFO - Running setup.py (path:/tmp/pip-bmnNaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:11 INFO - Running setup.py (path:/tmp/pip-tfkuS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:11 INFO - Running setup.py (path:/tmp/pip-8k_5Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:11 INFO - Running setup.py (path:/tmp/pip-kcpVcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:11 INFO - Running setup.py (path:/tmp/pip-rSDomM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:11 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)) 14:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:11 INFO - Running setup.py (path:/tmp/pip-_fpEHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:11 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)) 14:39:11 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)) 14:39:11 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)) 14:39:11 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)) 14:39:11 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)) 14:39:11 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)) 14:39:11 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)) 14:39:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:11 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 14:39:11 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 14:39:11 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 14:39:11 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 14:39:12 INFO - Downloading blessings-1.6.tar.gz 14:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:12 INFO - Installing collected packages: blessings 14:39:12 INFO - Running setup.py install for blessings 14:39:12 INFO - Successfully installed blessings 14:39:12 INFO - Cleaning up... 14:39:12 INFO - Return code: 0 14:39:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:13 INFO - Reading from file tmpfile_stdout 14:39:13 INFO - Current package versions: 14:39:13 INFO - argparse == 1.2.1 14:39:13 INFO - blessings == 1.6 14:39:13 INFO - blobuploader == 1.2.4 14:39:13 INFO - docopt == 0.6.1 14:39:13 INFO - functools32 == 3.2.3-2 14:39:13 INFO - jsonschema == 2.5.1 14:39:13 INFO - manifestparser == 1.1 14:39:13 INFO - mozInstall == 1.13 14:39:13 INFO - mozcrash == 1.0 14:39:13 INFO - mozdebug == 0.1 14:39:13 INFO - mozdevice == 0.51 14:39:13 INFO - mozfile == 1.2 14:39:13 INFO - mozhttpd == 0.7 14:39:13 INFO - mozinfo == 0.10 14:39:13 INFO - mozleak == 0.1 14:39:13 INFO - mozlog == 3.5 14:39:13 INFO - moznetwork == 0.27 14:39:13 INFO - mozprocess == 0.25 14:39:13 INFO - mozprofile == 0.28 14:39:13 INFO - mozrunner == 6.13 14:39:13 INFO - mozscreenshot == 0.1 14:39:13 INFO - mozsystemmonitor == 0.3 14:39:13 INFO - moztest == 0.8 14:39:13 INFO - mozversion == 1.4 14:39:13 INFO - psutil == 3.1.1 14:39:13 INFO - requests == 1.2.3 14:39:13 INFO - wsgiref == 0.1.2 14:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:13 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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:13 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 14:39:13 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 14:39:13 INFO - Using env: {'DISPLAY': ':0', 14:39:13 INFO - 'HOME': '/home/cltbld', 14:39:13 INFO - 'LANG': 'en_US.UTF-8', 14:39:13 INFO - 'LANGUAGE': 'en_US:en', 14:39:13 INFO - 'LOGNAME': 'cltbld', 14:39:13 INFO - 'MAIL': '/var/mail/cltbld', 14:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:13 INFO - 'MOZ_NO_REMOTE': '1', 14:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:13 INFO - 'NO_EM_RESTART': '1', 14:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:13 INFO - 'PWD': '/builds/slave/test', 14:39:13 INFO - 'SHELL': '/bin/bash', 14:39:13 INFO - 'SHLVL': '1', 14:39:13 INFO - 'TERM': 'linux', 14:39:13 INFO - 'TMOUT': '86400', 14:39:13 INFO - 'USER': 'cltbld', 14:39:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:13 INFO - '_': '/tools/buildbot/bin/python'} 14:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 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)) 14:39:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:39:14 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)) 14:39:14 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)) 14:39:14 INFO - Installing collected packages: simplejson 14:39:14 INFO - Running setup.py install for simplejson 14:39:14 INFO - building 'simplejson._speedups' extension 14:39:14 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 14:39:15 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 14:39:15 INFO - Successfully installed simplejson 14:39:15 INFO - Cleaning up... 14:39:15 INFO - Return code: 0 14:39:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:15 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 0x25741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, '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': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', '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 14:39:15 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 14:39:15 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 14:39:15 INFO - Using env: {'DISPLAY': ':0', 14:39:15 INFO - 'HOME': '/home/cltbld', 14:39:15 INFO - 'LANG': 'en_US.UTF-8', 14:39:15 INFO - 'LANGUAGE': 'en_US:en', 14:39:15 INFO - 'LOGNAME': 'cltbld', 14:39:15 INFO - 'MAIL': '/var/mail/cltbld', 14:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:15 INFO - 'MOZ_NO_REMOTE': '1', 14:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:15 INFO - 'NO_EM_RESTART': '1', 14:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:15 INFO - 'PWD': '/builds/slave/test', 14:39:15 INFO - 'SHELL': '/bin/bash', 14:39:15 INFO - 'SHLVL': '1', 14:39:15 INFO - 'TERM': 'linux', 14:39:15 INFO - 'TMOUT': '86400', 14:39:15 INFO - 'USER': 'cltbld', 14:39:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:15 INFO - '_': '/tools/buildbot/bin/python'} 14:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:39:15 INFO - Cleaning up... 14:39:15 INFO - Return code: 0 14:39:15 INFO - Running post-action listener: _resource_record_post_action 14:39:15 INFO - Running post-action listener: _start_resource_monitoring 14:39:15 INFO - Starting resource monitoring. 14:39:15 INFO - [mozharness: 2017-09-16 21:39:15.846367Z] Finished create-virtualenv step (success) 14:39:15 INFO - [mozharness: 2017-09-16 21:39:15.846830Z] Running install step. 14:39:15 INFO - Running pre-action listener: _resource_record_pre_action 14:39:15 INFO - Running main action method: install 14:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:16 INFO - Reading from file tmpfile_stdout 14:39:16 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:16 INFO - Reading from file tmpfile_stdout 14:39:16 INFO - Output received: 14:39:16 INFO - Usage: mozinstall [options] installer 14:39:16 INFO - Options: 14:39:16 INFO - -h, --help show this help message and exit 14:39:16 INFO - -d DEST, --destination=DEST 14:39:16 INFO - Directory to install application into. [default: 14:39:16 INFO - "/builds/slave/test"] 14:39:16 INFO - --app=APP Application being installed. [default: firefox] 14:39:16 INFO - mkdir: /builds/slave/test/build/application 14:39:16 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'] 14:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:39:33 INFO - Reading from file tmpfile_stdout 14:39:33 INFO - Output received: 14:39:33 INFO - /builds/slave/test/build/application/firefox/firefox 14:39:33 INFO - Running post-action listener: _resource_record_post_action 14:39:33 INFO - [mozharness: 2017-09-16 21:39:33.949645Z] Finished install step (success) 14:39:33 INFO - [mozharness: 2017-09-16 21:39:33.949981Z] Running setup-mitmproxy step. 14:39:33 INFO - Running pre-action listener: _resource_record_pre_action 14:39:33 INFO - Running main action method: setup_mitmproxy 14:39:33 INFO - Skipping: mitmproxy is not required 14:39:33 INFO - Running post-action listener: _resource_record_post_action 14:39:33 INFO - [mozharness: 2017-09-16 21:39:33.951597Z] Finished setup-mitmproxy step (success) 14:39:33 INFO - [mozharness: 2017-09-16 21:39:33.952017Z] Running run-tests step. 14:39:33 INFO - Running pre-action listener: _resource_record_pre_action 14:39:33 INFO - Running pre-action listener: _set_gcov_prefix 14:39:33 INFO - Running main action method: run_tests 14:39:33 WARNING - Try message not found. 14:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:39:33 INFO - Python 2.7.3 14:39:33 INFO - Return code: 0 14:39:33 INFO - grabbing minidump binary from tooltool 14:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:33 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 0x28e4090>, '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 0x28e4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28def90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:39:33 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 14:39:33 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 14:39:33 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 14:39:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:39:34 INFO - Return code: 0 14:39:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:39:34 INFO - ENV: RUST_BACKTRACE is now full 14:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 14:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 14:39:34 INFO - Using env: {'DISPLAY': ':0', 14:39:34 INFO - 'HOME': '/home/cltbld', 14:39:34 INFO - 'LANG': 'en_US.UTF-8', 14:39:34 INFO - 'LANGUAGE': 'en_US:en', 14:39:34 INFO - 'LOGNAME': 'cltbld', 14:39:34 INFO - 'MAIL': '/var/mail/cltbld', 14:39:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:39:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:34 INFO - 'MOZ_NO_REMOTE': '1', 14:39:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:34 INFO - 'NO_EM_RESTART': '1', 14:39:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:34 INFO - 'PWD': '/builds/slave/test', 14:39:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:39:34 INFO - 'RUST_BACKTRACE': 'full', 14:39:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:39:34 INFO - 'SHELL': '/bin/bash', 14:39:34 INFO - 'SHLVL': '1', 14:39:34 INFO - 'TERM': 'linux', 14:39:34 INFO - 'TMOUT': '86400', 14:39:34 INFO - 'USER': 'cltbld', 14:39:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:34 INFO - '_': '/tools/buildbot/bin/python'} 14:39:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 14:39:34 INFO - mozversion application_buildid: 20170916205117 14:39:34 INFO - mozversion application_changeset: 44e56a4d482a0959e00afb371872035caf3cd56d 14:39:34 INFO - mozversion application_display_name: Nightly 14:39:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:39:34 INFO - mozversion application_name: Firefox 14:39:34 INFO - mozversion application_remotingname: firefox 14:39:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:39:34 INFO - mozversion application_vendor: Mozilla 14:39:34 INFO - mozversion application_version: 57.0a1 14:39:34 INFO - mozversion platform_buildid: 20170916205117 14:39:34 INFO - mozversion platform_changeset: 44e56a4d482a0959e00afb371872035caf3cd56d 14:39:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:39:34 INFO - mozversion platform_version: 57.0a1 14:39:34 INFO - using testdate: 1505597974 14:39:34 INFO - actual date: 1505597974 14:39:34 INFO - starting webserver on 'localhost:44243' 14:39:34 INFO - SUITE-START | Running 2 tests 14:39:34 INFO - TEST-START | dromaeo_css 14:39:34 INFO - Initialising browser for dromaeo_css test... 14:39:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44243/getInfo.html -profile /tmp/tmpFXT2hl/profile 14:39:34 INFO - TEST-INFO | started process 5078 (/builds/slave/test/build/application/firefox/firefox http://localhost:44243/getInfo.html) 14:39:39 INFO - TEST-INFO | 5078: exit 0 14:39:39 INFO - Browser initialized. 14:39:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:39:39 INFO - Using env: {'DISPLAY': ':0', 14:39:39 INFO - 'HOME': '/home/cltbld', 14:39:39 INFO - 'JSGC_DISABLE_POISONING': '1', 14:39:39 INFO - 'LANG': 'en_US.UTF-8', 14:39:39 INFO - 'LANGUAGE': 'en_US:en', 14:39:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:39:39 INFO - 'LOGNAME': 'cltbld', 14:39:39 INFO - 'MAIL': '/var/mail/cltbld', 14:39:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:39:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:39:39 INFO - 'MOZ_CRASHREPORTER': '1', 14:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:39:39 INFO - 'MOZ_NO_REMOTE': '1', 14:39:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:39 INFO - 'NO_EM_RESTART': '1', 14:39:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:39 INFO - 'PWD': '/builds/slave/test', 14:39:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:39:39 INFO - 'RUST_BACKTRACE': 'full', 14:39:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:39:39 INFO - 'SHELL': '/bin/bash', 14:39:39 INFO - 'SHLVL': '1', 14:39:39 INFO - 'TERM': 'linux', 14:39:39 INFO - 'TMOUT': '86400', 14:39:39 INFO - 'USER': 'cltbld', 14:39:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:39 INFO - '_': '/tools/buildbot/bin/python'} 14:39:39 INFO - TEST-INFO | started process 5311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFXT2hl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:40 INFO - PID 5311 | 14:39:40 INFO - PID 5311 | (/builds/slave/test/build/application/firefox/firefox:5360): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:39:40 INFO - PID 5311 | 14:39:51 INFO - PID 5311 | RSS: Main: 157077504 14:39:51 INFO - PID 5311 | 14:42:47 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44243/tests/dromaeo/cssquery-ext.html) 14:42:49 INFO - PID 5311 | RSS: Main: 156590080 14:42:49 INFO - PID 5311 | 14:45:50 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44243/tests/dromaeo/cssquery-ext.html (next: http://localhost:44243/tests/dromaeo/cssquery-jquery.html) 14:45:51 INFO - PID 5311 | RSS: Main: 156651520 14:45:51 INFO - PID 5311 | 14:48:53 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44243/tests/dromaeo/cssquery-mootools.html) 14:48:53 INFO - PID 5311 | RSS: Main: 158392320 14:48:53 INFO - PID 5311 | 14:51:55 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44243/tests/dromaeo/cssquery-prototype.html) 14:51:56 INFO - PID 5311 | RSS: Main: 157270016 14:51:56 INFO - PID 5311 | 14:54:59 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44243/tests/dromaeo/cssquery-yui.html) 14:55:00 INFO - PID 5311 | RSS: Main: 158343168 14:55:00 INFO - PID 5311 | 14:58:01 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44243/tests/dromaeo/cssquery-yui.html (next: http://localhost:44243/tests/dromaeo/cssquery-dojo.html) 14:58:02 INFO - PID 5311 | RSS: Main: 160776192 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | __start_tp_report 14:58:02 INFO - PID 5311 | _x_x_mozilla_page_load 14:58:02 INFO - PID 5311 | _x_x_mozilla_page_load_details 14:58:02 INFO - PID 5311 | |i|pagename|runs| 14:58:02 INFO - PID 5311 | |0;dojo.html;2976.642802863654;3103.627564692236;3121;3145.8269795161273;3160.336329370832;6334.809955701325;6367.840803979902;6382.138411314471;6415.679216039202;6422.807315780522;6178.104174894649;6237.438630523252;6286.874262514747;6291.811245662638;6300.991841305392;5769.019266724646;5782.508486778629;5827.766889324422;5847.473727364536;5870.442307980735;1344.1471429082567;5850.444207800252;5906.4093590640805;5917.378675239102;5948.851278718023;5736.110902810071;5752.252207213057;5823.79616713413;5866.296044474648;5883.029300165467;5764.16419619157;5788.855278618068;5862.999999999957;5864.941350586525;5878.118282257653;5747.655140691572;5771.797987070432;5810.738516766755;5842.386549412293;5844.620099693549;6275.403836635513;6296.929521981228;6315.905261421082;6398.232212134527;6399.552031357807;6727.29363416844;6780.254172041072;6804.455643548505;6841.555298905605;6865.656717164122;6838.350356716104;6840.794776156723;6868.759593414206;6876.415504682108;6878.518503704742;6282.87434251317;6298.212723409574;6330.905036424458;6366.77716279928;6372.968135159341;6967.198772141269;6977.406920411822;6983.196932352743;7064.798984172703;7069.717211311593;6624.966875165594;6639.336066393322;6702.463802895757;6714.294999025032;6722.29415911332;6786.830329241809;6818.977153426927;6843.931560684329;6845.863082738417;6848.589084654936;6704.765333213411;6737.932620673829;6741.1910570731825;6783.966080169567;6794.626295553792;6718.05947167397;6742.898856517156;6758.357955994173;6869.347411995853;6878.7248510060035;5250.369955605275;5272.6836389816735;5273.31446911899;5283.920741188886;5294.97352513235;4616.3537104805355;4623.86128416148;4627.722336659811;4635.837745678885;4640.373549570832;5821.970890145522;5834.066549352168;5879.559033072536;5887.8233652990475;5888.175655408247;6806.183258008971;6806.625635589991;6875.5530890491955;6883.483738719616;6889.689963951634;5813.56398270123;5826.213461182686;5884.676342801187;5897.2038774765715;5905.025670764362;5676.375598684142;5741.540676745851;5741.684207368551;5745.425457454305;5747.879163563149;6495.155629768195;6531.118299029666;6588.8023359299295;6603.669816509156;6617.305182955816;6781.728730850711;6853.623050732258;6858.142732158481;6861.348171923659;6875.140607424072;6494.4804415645685;6498.252700939453;6519.1199188110895;6588.40704336612;6600.339966003361;6529.249136349191;6672.132622759011;6695.698693558704;6724.798256052326;6749.291324410866;6837.179538455417;6865.27914568983;6906.274841141608;6931.584104953719;6939.930600693929;6515.771947981798;6542.8364290893105;6559.048937903882;6631.171103612049;6637.834054148685;6433.453156481564;6532.738690452328;6575.342465753386;6644.767433139817;6662.433693136138;6442.581232219891;6446.871062578628;6456.6771661415805;6458.192725909262;6458.451031662174;6494.09082728409;6591.110200122922;6592.077109204619;6592.934070659424;6701.530892837454;6411.358864113738;6411.711472983634;6488.643124628191;6501.44737697301;6518.185226846645 14:58:02 INFO - PID 5311 | |1;ext.html;860.2214995429136;884.0982198157877;886.4415418286478;890.2210565754964;891.2825175733532;37755;40883.18233635329;41314.38028429569;41390.379144312785;41409.79295103528;38403.615963840355;38670;38713.806430967874;38761;38858.417123743166;7020.613866237355;7121.715131394738;7132.215456299803;7655.119661238945;7873.25204105609;7757.961210193969;7865.921340786576;7870.252326029018;7870.842583148334;7871.960640196819;7787.844243115134;7828.373730101578;7831;7893.250141236602;7902.3678105751405;7774.650140743652;7826.413019023567;7839.098503672037;7840.411969102283;7842.411819113589;7718;7806.72676456327;7809.101953275389;7814.3357814585825;7815.804604884866;37579.81210093932;37891.62108378908;37924.24151516954;37941.43087853684;37947.620523794685;3472.5659292588425;3505.2113274513285;3509.877154299613;3511.7015053720465;3516.1736991806906;30813.845930770425;30931.381372372653;31016;31055.689443105504;31113.22216944572;5069.923951140736;5132.332796736438;5200.817971370984;5209.192575150858;5290.735463226823;191812;192505;192739;192903;193153.03423482933;42774;43287.134257314676;49454.50545494571;49509.257361139615;49572.75213623909;44609.77695111504;51053;51430.74284628553;51693.22460163101;51834.48165518372;15977.360905563879;16009.359625614845;16124.193790310437;16154.515364539082;16169.514914552583;13152.342382880817;13209.669758255928;13262.469501220035;13274.601761947157;13282.66793330155;14158.575242742734;14198;14289.92855035739;14310.85689143116;14429;5782.739776709974;5825.88348233033;5845.883082338414;5861.1537365729655;5910.320313164041;985.935914165577;999.8500224966314;1002.2733518199248;1016.1159790981745;1021.8569400283966;22107.778922210895;22379.104835806385;22754.544909102056;22824.885875570515;23102.65346019811;1078.2075174746556;1093.420487141816;1100.1748688483638;1100.5542755184163;1120.5125770289949;11886.762264754829;11930.284182949052;11978.041756659446;12011.279323240633;12096.274223546616;234385;235319;235751;236053;236450;50994.74502627463;51152.976940461725;54726.452735472136;55799;55836.72081639566;1388.1809732258016;1415.8867290616931;1418.6027912184604;1433.1616004637197;1454.4909281751513;26406.603900941886;26575.468490629693;26710.332241694112;27035.72964270332;27517.31206719848;37611.43582846205;37740.81129594334;37768.62231377651;37804.2439151221;37846.62153378431;192395;194520;195092;195391;195889;33273.16817079592;35452.46821297734;36168;36180.27639447249;36220;45447.77276113598;45696.31455528103;45832.7708361456;45897.54102458933;45955;33587.49618755769;34048.319033619686;34105.48841767326;34367.65632343745;34405.655943440244;33526.329473410886;33621.66378336185;33633.83183084167;33847.492287616195;34272.314553709286;36267.81866090652;37712.81143594265;37811.432828507044;37856.43215351827;38284.2343153141;32433.675663243066;32502.51246231261;33022;33501.32997340088;33560.328793423505;23743.525129496968;24507.63238551459;24998.75001249964;25576;25662.230133096036 14:58:02 INFO - PID 5311 | |2;jquery.html;548.5529293625694;554.9805756798513;559.3036669346661;577.1487056591528;583.6060659055138;22689.54620907583;23693.881530592324;23786.88106559469;23805.404864878386;23808.999999999978;23502.294931152093;24572.139975100876;24599.63100553493;24848.75151248487;25020.624690629655;6420.839479013027;6517.315681853408;6520.9673951630175;6543.3783790540065;6555.541112122153;6420.357964203566;6519.282878883319;6527.608343499382;6543.443807276387;6733.528652994292;6935.271796461375;6999.720011199546;7085.2914708529;7088.610126443069;7089.71641134354;7023.929760702379;7063.328983746535;7093.219745827955;7094.858102837914;7102.1832489263625;6925.826854328631;6940.514164008521;6946.444284457282;6953.304669533057;6964.4428445724225;28829.42341153165;29173.708262917313;29980;30230.24424389386;30480.8475957621;2027.168860767093;2046.3451695457459;2054.137262349817;2054.6404379233722;2054.9280775172797;20207.797922020887;20902.268420605207;20920.267790627255;20967.895160524098;21016.474588135265;2450.8529488230765;2519.3071905226025;2580.0324878170686;2587.2884956636885;2607.413332000304;128970.3551482246;137264;138038.30980845133;141879.99999999898;146651;20408.59182816365;21106.155753769985;21303.68044479334;21666.783332166477;22319.776802232096;43185.56814431815;43344.566554334684;43373.56626433758;43442.34836477455;43490.782546087066;11384.715382115513;11455.885441145649;11483.42582870853;11483.942580287045;11845.170838041427;9701.757456063513;9733.172680322252;9781.217502599775;9826;9832.557534910946;11162.772095069537;11225.270357426742;11339.773204535863;11397.373144477133;11422.885771142182;4000.6599439047427;4038.273110840018;4124.876253712393;4139.81370838307;4171.581662234855;952.3952290295574;969.9669851608015;979.480875136179;989.9010098990043;1001;19073.904630476758;19248.518787030436;19274.421767347;19284.1322140504;19817.810931344164;1041.7239431550645;1042.7810159866513;1046.1473898772476;1051.6582110813863;1053.625962783201;10471.361127070046;10836.133109351233;10845.891541084646;10960.561577536968;11065.612703555336;459488;463165;467631;468459;490214;111802;112437.43781281204;115558.42220788842;117160.41419792846;117555;1033.7984093101772;1077.7790552936629;1164.5923926625783;1188.5602327139013;1219.4329636718792;19749.70375444398;19846.90076549666;20065.197392104736;20175.293864714666;20284.695729563773;54457.72771136119;54575.454245458626;54872.45127548673;55622.775088995986;56598.71700641471;67682;68128.3187168122;69365.65317173382;70171.29828701852;70651.64674176596;19359.3224237151;19832.20671173137;20074;20095.19619215215;20444.97775111268;22312.66531002004;22515.88742056279;22536.774632254124;22551.436214094778;22586.661200081682;18101.818981810015;18260.543486412946;18284.268629254682;18392.172352244448;18418.35535756242;16262.268197931358;16511.504654860375;16601.584960376087;16948.491545253662;17072.914635426743;17985.280588776302;18765.530861728566;18825.811741882408;19086.522836929187;19097.949612770874;19515;19667.901660491607;19808.70286945668;19872.60254794867;19877.900610496854;17887.642247155243;18079.548011299823;18229.908850456195;18398.908005460424;18404.895706257666 14:58:02 INFO - PID 5311 | |3;mootools.html;1325.3307079924637;1367.7948307753843;1370.8217931668885;1386.126740153703;1386.6325423762705;14970.401183952628;15664.295106720196;15683.843161568395;15686.294116764744;15720;15134.848651513481;15378.769318460232;15386.923065384686;15389.076655400684;15414;2696.3663539068352;2808.4102338508837;2813.1701148161237;2814.704456032118;2816.3381605322734;2654.1241390341143;2700.054980756739;2705.5130076586206;2720.7687346575567;2723.3872378714827;2671.185288487011;2678.825876318043;2694.676638803346;2696.0294294054124;2698.109623824143;2593.597992311195;2621.2398404462683;2629.421527263999;2630.18464276075;2641.0492222799776;2521.773040426352;2553.527597394488;2563.9615405768927;2681.316264352597;2730.808843380964;14894;14947.40210391583;14950.47673331439;14985.250737463191;15009.849901501064;8009.439339246255;8331.041930178046;8339.83320333596;8343.749687509384;8349.749507514784;5230;5351.678899266057;5600.271964644611;5639.830805075854;5747.166660834156;1834.4863438237314;1858.628274345123;1899.5441094137445;1930.7683078030586;1934.1586409911592;26970.730292697215;27056.59415108775;27244.31889202766;27282.31794205121;27329.31676708098;7307.525010874382;7369.594672292968;7612.373731062775;7632.1986191450205;7668.961655191688;17262.65474690499;17332.393366232373;17357.7396339055;17361.392351267645;17370.739438908426;8023.518588884685;8166.224208700164;8179.222973817477;8181.18188181189;8184.754457366289;7465.514741541782;7496.512726672749;7542.962285188539;7605.429592780563;7613.124490683642;5031.597472202288;5153.5361817436615;5206.479352064764;5245.790168393298;5331.653442526223;1351.8242628458238;1386.4939297156666;1474.550262170027;1489.5903626502798;1549.806274215723;906.9727908162765;915.3592485260211;927.7819712367589;930.7766136127416;939.4926739560698;7980.281774640311;8037.919620803717;8144.755657330171;8186.222308880766;8305.169483051768;981.6760469045198;992.176493510399;997.65082221222;1003.9297249192487;1023.9795204096025;5281.973590132025;5421.864453388697;5455.399906010336;5504.944950550524;5526.198701188305;21011.684824727643;22052.448688782908;22255;22288.219912302993;22301.88849055777;21011.8949405252;21904;22006.559868802535;22110;22361.664575031387;11323.094152467782;11484;11510.194286399872;11520.193586449035;11567.479463424166;8165.305948994402;8229.300509456763;8240.21717936795;8337.416380853281;8402.369822263232;18974.810251897303;19094;19379;19395.709064363764;19446.513837154183;19073;19180.232790688773;19310.8068919309;19916.800831992074;19923.501912452306;10914.50884710174;11119.054880335261;11126.276792008493;11134.164937629872;11139.72150696239;13920.58238252854;14049.929750351183;14052.297385130907;14113.2943352834;14205.786913196516;10884.945575272073;11525.711857203636;11552.364619945984;11774.3524106175;12074;10393.740156495845;10643.521041553304;10671.46642667879;10808.513616887101;10974.231803773979;10029.348092373972;10320.48397580133;10322;10453.47732613351;10462.895371046496;7220.602866842374;7381.889271660822;7410.62946852666;7428.925710742823;7487.47587668858;6971.6862741175755;6987.580745155307;7046.718131274692;7087.291270872872;7110.43116550685 14:58:02 INFO - PID 5311 | |4;prototype.html;496.2779156327544;500.03676740936845;516.3855012535081;518.8858451140749;520.4535238000101;6144.662043587601;6184.56708030438;6191.50467962563;6265.843353916149;6278.399008252901;6168.876622467559;6221.937780622193;6265.467435267997;6284.072454715802;6290.559660823744;5148.871278218046;5170.819021334254;5214.217867319894;5220.373555173384;5236.109861323565;4914.361133052698;5021.347224860763;5026.371703537058;5071.873203169932;5196.766145523442;5011.198208286675;5052.444231134591;5057.974710126444;5063.74681265937;5072.137736584789;4972.801087956495;4988.700677959316;5029.84910452687;5034.144195486776;5041.899162016776;4480.6191473724775;4519.389882365905;4534.13851368239;4543.909121817545;4552.908941821178;6217.347178546278;6235.563510554263;6241.251049873998;6268.934281172212;6285.340039295854;5656.8905581971785;5697.373288938214;5704.22992895962;5770.826875193751;5791.175779629403;6537.5750576212395;6571.441427478622;6621.172353455818;6637.966810165966;6647.86704265912;4925.729084900329;4944.629152813553;4954.9752251238515;4963.528464795839;4970.353853998993;7006.369426751617;7030.718771249195;7052.188998265163;7078.92921070793;7094.787156385317;5005.549500544968;5006.973570418056;5029.119904016782;5032.647714659939;5040.899182016413;5116.718580478035;5131.512506311894;5136.871578210575;5141.074606570854;5153.587712982952;5754.4533269339345;5755.424457554211;5763.164341170507;5772.336181339116;5784.016717158093;6322.683865806691;6642.535022548472;6645.900311495331;6648.202215734046;6668.599884006975;1632.6244963658426;1688.240291868664;1744.8778585498894;1760.5862622283753;1761.2250609731677;1197.3115458611333;1216.47691492659;1217.15407791584;1233.3586535001748;1234.6542967968983;5505.614606977473;5666.575006874501;5688.601797874109;5719.971400142973;5721.971390143022;6589.242237142694;6641.833954151089;6703.932960670429;6788.830279243059;6848.589084654936;5717.342505611908;5787.826365209051;5793.362730099686;5795.333536643256;5833.67914764692;3548.6628770266784;3551.5205447264807;3583.6416358364477;3610.530631017951;3618.16782140104;6548.377904099103;6562.967185164139;6577.769778057841;6590;6606.933930660728;6988.266232045664;6998.265182155902;7007.544509606859;7016.5790052595985;7078.221395646475;6455.2253729553695;6501.739930402826;6520.576162549419;6556.442702370352;6596.340365963365;6689.264180939996;6757.93242067573;6766.7969960901255;6784.626845523544;6838.658067096725;6663.233728121134;6680.766173183915;6701.530892837454;6719.193696756421;6737.326267373223;6457.289698133295;6482.384173503509;6522.510811689048;6588.670566471753;6647.401733843977;4978.029284289529;4986.15235409974;5002.199648056294;5014.648974571891;5023;6342.175517182736;6555.3772391622715;6638.203415589967;6712.429443497357;6768.932310677027;6158.815235542941;6424.38968298011;6454.903176452263;6466.612003279818;6592.373724496357;6387.552871298964;6496.9025464617125;6508.902366464602;6519.445847103049;6548.3124271950755;6339.084021350046;6381.1704478417505;6383.904241436475;6492.123563318892;6495.707693153914;6518.902216466851;6529.967350163219;6580.901286480803;6616.106825578485;6671.097408016365;6426.4537514311805;6427.196600424947;6430.421262086435;6465.321141280286;6465.482761379172 14:58:02 INFO - PID 5311 | |5;yui.html;894.4096896048609;903.5121034641294;919.4988731141527;929.7303781903248;930.0792215706448;18263.45209643711;19081;19092.61814763704;19099.140538675758;19151.99999999998;17564.59703043505;17821.108944552787;18110;18763.15565799539;18838.43484695458;930.8510638297873;935.7894473743421;937.8921424036221;938.4744543055876;939.0562484702864;954.8424509955848;955.1737746848995;955.2024059909984;955.4028732042474;956.8277710012195;1019.2152042926941;1030.5002073994144;1032.989670103297;1033.0702367868942;1033.1631378583334;1016.5019140621042;1021.5045702834119;1027.2706378471257;1028.2647906746674;1030.6238223048572;722.5159143373952;734.1740541890373;736.0321177651372;745.4334705623711;746.8058304840727;20282.69575956362;20461.079251433723;20466.181352745873;20471.283505077252;20486.692699609517;21215.78784212169;21717.45706357338;22525.324240272817;22761.77238227613;22791.08835646572;17710.822891771048;17875.463736087808;17884.374046908295;17912.462626121105;17991.280348786033;3824.330742120118;3852.9211820690252;3854.209886973164;3857.8263978121054;3859.112404147034;146777;146780;147905.26047369695;149861;152995;16701.83298167027;16932.57668558296;17041.318347266217;17081.572960675832;17090.914545427193;31963.840180798947;32255.51616725751;32428.83785581104;32441.675583244338;32495.675043249266;8613.61238744258;8712.564371781385;8749.91250087491;8785.209331160098;8923.107689231025;4136.21411931732;4212.410262563244;4227.534971153171;4230.175115852379;4258.808353624095;5202.583793296603;5287.4976877196605;5301.973490132602;5326.201069839555;5331.5201631853315;970.9126178643955;1015.9288849780593;1029.3875144289136;1038.159091136182;1052.4001319247955;691.9827004324932;710.4529512275519;710.8084699698318;711.9181294151135;717.5300178383168;10755.193360497993;11082.944585277022;11279.718007049725;11622.476988535536;12191.207571507824;671.9462443004547;690.413148823496;696.4045740891567;714.0752725220748;717.2683862460261;5350.224217488442;5391.460853914656;5449.264349312792;5453.836384908459;5561.443855614487;125968.37015814862;128132;129104;130361;132628;107558;108690;109347;109481.45259273653;110518.44740776245;95034;98983;99538.99999999854;99809;102062.48968755257;9880.950595246977;9978.750531236778;10026.348287361297;10045.296829221885;10087.69736907894;42964.78517607392;43569.78215108904;43810;45088;45157.77421113005;57155;57451.42548574628;59001.11498327443;59055;59227.70386148042;13649;13726.931365343109;13797.79303310431;13919.88640908745;13932.860671393157;16629.833701663312;16679.749803753195;16881;16904;17010.064446455563;15561.221938902783;15598.220088995731;15614.84385156134;15656.37374505007;15823.367065317258;13554.525591604246;13628.114172578751;13779.242141682304;13818.170909745448;13838.515651952133;14802.62993425173;14839.629009274855;14980.325885334969;14985.325660345092;15137.318820652878;10685.679429616814;11092.168087393638;11126.944365278121;11237.887621124011;11348.148888833206;10457.9477102614;10506.896775838733;10572.20708446885;10872.402017889091;10929.836052459379 14:58:02 INFO - PID 5311 | __end_tp_report 14:58:02 INFO - PID 5311 | __start_cc_report 14:58:02 INFO - PID 5311 | _x_x_mozilla_cycle_collect,293 14:58:02 INFO - PID 5311 | __end_cc_report 14:58:02 INFO - PID 5311 | __startTimestamp1505599082005__endTimestamp 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | ------- Summary: start ------- 14:58:02 INFO - PID 5311 | Number of tests: 6 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | [#0] dojo.html Cycles:165 Average:6206.18 Median:6458.45 stddev:855.40 (13.2%) stddev-sans-first:819.65 14:58:02 INFO - PID 5311 | Values: 2976.6 3103.6 3121.0 3145.8 3160.3 6334.8 6367.8 6382.1 6415.7 6422.8 6178.1 6237.4 6286.9 6291.8 6301.0 5769.0 5782.5 5827.8 5847.5 5870.4 1344.1 5850.4 5906.4 5917.4 5948.9 5736.1 5752.3 5823.8 5866.3 5883.0 5764.2 5788.9 5863.0 5864.9 5878.1 5747.7 5771.8 5810.7 5842.4 5844.6 6275.4 6296.9 6315.9 6398.2 6399.6 6727.3 6780.3 6804.5 6841.6 6865.7 6838.4 6840.8 6868.8 6876.4 6878.5 6282.9 6298.2 6330.9 6366.8 6373.0 6967.2 6977.4 6983.2 7064.8 7069.7 6625.0 6639.3 6702.5 6714.3 6722.3 6786.8 6819.0 6843.9 6845.9 6848.6 6704.8 6737.9 6741.2 6784.0 6794.6 6718.1 6742.9 6758.4 6869.3 6878.7 5250.4 5272.7 5273.3 5283.9 5295.0 4616.4 4623.9 4627.7 4635.8 4640.4 5822.0 5834.1 5879.6 5887.8 5888.2 6806.2 6806.6 6875.6 6883.5 6889.7 5813.6 5826.2 5884.7 5897.2 5905.0 5676.4 5741.5 5741.7 5745.4 5747.9 6495.2 6531.1 6588.8 6603.7 6617.3 6781.7 6853.6 6858.1 6861.3 6875.1 6494.5 6498.3 6519.1 6588.4 6600.3 6529.2 6672.1 6695.7 6724.8 6749.3 6837.2 6865.3 6906.3 6931.6 6939.9 6515.8 6542.8 6559.0 6631.2 6637.8 6433.5 6532.7 6575.3 6644.8 6662.4 6442.6 6446.9 6456.7 6458.2 6458.5 6494.1 6591.1 6592.1 6592.9 6701.5 6411.4 6411.7 6488.6 6501.4 6518.2 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | [#1] ext.html Cycles:180 Average:37964.38 Median:36174.14 stddev:53993.75 (149.3%) stddev-sans-first:54073.34 14:58:02 INFO - PID 5311 | Values: 860.2 884.1 886.4 890.2 891.3 37755.0 40883.2 41314.4 41390.4 41409.8 38403.6 38670.0 38713.8 38761.0 38858.4 7020.6 7121.7 7132.2 7655.1 7873.3 7758.0 7865.9 7870.3 7870.8 7872.0 7787.8 7828.4 7831.0 7893.3 7902.4 7774.7 7826.4 7839.1 7840.4 7842.4 7718.0 7806.7 7809.1 7814.3 7815.8 37579.8 37891.6 37924.2 37941.4 37947.6 3472.6 3505.2 3509.9 3511.7 3516.2 30813.8 30931.4 31016.0 31055.7 31113.2 5069.9 5132.3 5200.8 5209.2 5290.7 191812.0 192505.0 192739.0 192903.0 193153.0 42774.0 43287.1 49454.5 49509.3 49572.8 44609.8 51053.0 51430.7 51693.2 51834.5 15977.4 16009.4 16124.2 16154.5 16169.5 13152.3 13209.7 13262.5 13274.6 13282.7 14158.6 14198.0 14289.9 14310.9 14429.0 5782.7 5825.9 5845.9 5861.2 5910.3 985.9 999.9 1002.3 1016.1 1021.9 22107.8 22379.1 22754.5 22824.9 23102.7 1078.2 1093.4 1100.2 1100.6 1120.5 11886.8 11930.3 11978.0 12011.3 12096.3 234385.0 235319.0 235751.0 236053.0 236450.0 50994.7 51153.0 54726.5 55799.0 55836.7 1388.2 1415.9 1418.6 1433.2 1454.5 26406.6 26575.5 26710.3 27035.7 27517.3 37611.4 37740.8 37768.6 37804.2 37846.6 192395.0 194520.0 195092.0 195391.0 195889.0 33273.2 35452.5 36168.0 36180.3 36220.0 45447.8 45696.3 45832.8 45897.5 45955.0 33587.5 34048.3 34105.5 34367.7 34405.7 33526.3 33621.7 33633.8 33847.5 34272.3 36267.8 37712.8 37811.4 37856.4 38284.2 32433.7 32502.5 33022.0 33501.3 33560.3 23743.5 24507.6 24998.8 25576.0 25662.2 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | [#2] jquery.html Cycles:180 Average:35402.92 Median:22316.22 stddev:79258.90 (355.2%) stddev-sans-first:79438.04 14:58:02 INFO - PID 5311 | Values: 548.6 555.0 559.3 577.1 583.6 22689.5 23693.9 23786.9 23805.4 23809.0 23502.3 24572.1 24599.6 24848.8 25020.6 6420.8 6517.3 6521.0 6543.4 6555.5 6420.4 6519.3 6527.6 6543.4 6733.5 6935.3 6999.7 7085.3 7088.6 7089.7 7023.9 7063.3 7093.2 7094.9 7102.2 6925.8 6940.5 6946.4 6953.3 6964.4 28829.4 29173.7 29980.0 30230.2 30480.8 2027.2 2046.3 2054.1 2054.6 2054.9 20207.8 20902.3 20920.3 20967.9 21016.5 2450.9 2519.3 2580.0 2587.3 2607.4 128970.4 137264.0 138038.3 141880.0 146651.0 20408.6 21106.2 21303.7 21666.8 22319.8 43185.6 43344.6 43373.6 43442.3 43490.8 11384.7 11455.9 11483.4 11483.9 11845.2 9701.8 9733.2 9781.2 9826.0 9832.6 11162.8 11225.3 11339.8 11397.4 11422.9 4000.7 4038.3 4124.9 4139.8 4171.6 952.4 970.0 979.5 989.9 1001.0 19073.9 19248.5 19274.4 19284.1 19817.8 1041.7 1042.8 1046.1 1051.7 1053.6 10471.4 10836.1 10845.9 10960.6 11065.6 459488.0 463165.0 467631.0 468459.0 490214.0 111802.0 112437.4 115558.4 117160.4 117555.0 1033.8 1077.8 1164.6 1188.6 1219.4 19749.7 19846.9 20065.2 20175.3 20284.7 54457.7 54575.5 54872.5 55622.8 56598.7 67682.0 68128.3 69365.7 70171.3 70651.6 19359.3 19832.2 20074.0 20095.2 20445.0 22312.7 22515.9 22536.8 22551.4 22586.7 18101.8 18260.5 18284.3 18392.2 18418.4 16262.3 16511.5 16601.6 16948.5 17072.9 17985.3 18765.5 18825.8 19086.5 19097.9 19515.0 19667.9 19808.7 19872.6 19877.9 17887.6 18079.5 18229.9 18398.9 18404.9 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | [#3] mootools.html Cycles:180 Average:9463.29 Median:2607.42 stddev:6801.03 (260.8%) stddev-sans-first:6792.62 14:58:02 INFO - PID 5311 | Values: 1325.3 1367.8 1370.8 1386.1 1386.6 14970.4 15664.3 15683.8 15686.3 15720.0 15134.8 15378.8 15386.9 15389.1 15414.0 2696.4 2808.4 2813.2 2814.7 2816.3 2654.1 2700.1 2705.5 2720.8 2723.4 2671.2 2678.8 2694.7 2696.0 2698.1 2593.6 2621.2 2629.4 2630.2 2641.0 2521.8 2553.5 2564.0 2681.3 2730.8 14894.0 14947.4 14950.5 14985.3 15009.8 8009.4 8331.0 8339.8 8343.7 8349.7 5230.0 5351.7 5600.3 5639.8 5747.2 1834.5 1858.6 1899.5 1930.8 1934.2 26970.7 27056.6 27244.3 27282.3 27329.3 7307.5 7369.6 7612.4 7632.2 7669.0 17262.7 17332.4 17357.7 17361.4 17370.7 8023.5 8166.2 8179.2 8181.2 8184.8 7465.5 7496.5 7543.0 7605.4 7613.1 5031.6 5153.5 5206.5 5245.8 5331.7 1351.8 1386.5 1474.6 1489.6 1549.8 907.0 915.4 927.8 930.8 939.5 7980.3 8037.9 8144.8 8186.2 8305.2 981.7 992.2 997.7 1003.9 1024.0 5282.0 5421.9 5455.4 5504.9 5526.2 21011.7 22052.4 22255.0 22288.2 22301.9 21011.9 21904.0 22006.6 22110.0 22361.7 11323.1 11484.0 11510.2 11520.2 11567.5 8165.3 8229.3 8240.2 8337.4 8402.4 18974.8 19094.0 19379.0 19395.7 19446.5 19073.0 19180.2 19310.8 19916.8 19923.5 10914.5 11119.1 11126.3 11134.2 11139.7 13920.6 14049.9 14052.3 14113.3 14205.8 10884.9 11525.7 11552.4 11774.4 12074.0 10393.7 10643.5 10671.5 10808.5 10974.2 10029.3 10320.5 10322.0 10453.5 10462.9 7220.6 7381.9 7410.6 7428.9 7487.5 6971.7 6987.6 7046.7 7087.3 7110.4 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | [#4] prototype.html Cycles:180 Average:5546.29 Median:6219.64 stddev:1555.10 (25.0%) stddev-sans-first:1512.57 14:58:02 INFO - PID 5311 | Values: 496.3 500.0 516.4 518.9 520.5 6144.7 6184.6 6191.5 6265.8 6278.4 6168.9 6221.9 6265.5 6284.1 6290.6 5148.9 5170.8 5214.2 5220.4 5236.1 4914.4 5021.3 5026.4 5071.9 5196.8 5011.2 5052.4 5058.0 5063.7 5072.1 4972.8 4988.7 5029.8 5034.1 5041.9 4480.6 4519.4 4534.1 4543.9 4552.9 6217.3 6235.6 6241.3 6268.9 6285.3 5656.9 5697.4 5704.2 5770.8 5791.2 6537.6 6571.4 6621.2 6638.0 6647.9 4925.7 4944.6 4955.0 4963.5 4970.4 7006.4 7030.7 7052.2 7078.9 7094.8 5005.5 5007.0 5029.1 5032.6 5040.9 5116.7 5131.5 5136.9 5141.1 5153.6 5754.5 5755.4 5763.2 5772.3 5784.0 6322.7 6642.5 6645.9 6648.2 6668.6 1632.6 1688.2 1744.9 1760.6 1761.2 1197.3 1216.5 1217.2 1233.4 1234.7 5505.6 5666.6 5688.6 5720.0 5722.0 6589.2 6641.8 6703.9 6788.8 6848.6 5717.3 5787.8 5793.4 5795.3 5833.7 3548.7 3551.5 3583.6 3610.5 3618.2 6548.4 6563.0 6577.8 6590.0 6606.9 6988.3 6998.3 7007.5 7016.6 7078.2 6455.2 6501.7 6520.6 6556.4 6596.3 6689.3 6757.9 6766.8 6784.6 6838.7 6663.2 6680.8 6701.5 6719.2 6737.3 6457.3 6482.4 6522.5 6588.7 6647.4 4978.0 4986.2 5002.2 5014.6 5023.0 6342.2 6555.4 6638.2 6712.4 6768.9 6158.8 6424.4 6454.9 6466.6 6592.4 6387.6 6496.9 6508.9 6519.4 6548.3 6339.1 6381.2 6383.9 6492.1 6495.7 6518.9 6530.0 6580.9 6616.1 6671.1 6426.5 6427.2 6430.4 6465.3 6465.5 14:58:02 INFO - PID 5311 | 14:58:02 INFO - PID 5311 | [#5] yui.html Cycles:180 Average:24706.70 Median:19095.88 stddev:37000.17 (193.8%) stddev-sans-first:37060.77 14:58:02 INFO - PID 5311 | Values: 894.4 903.5 919.5 929.7 930.1 18263.5 19081.0 19092.6 19099.1 19152.0 17564.6 17821.1 18110.0 18763.2 18838.4 930.9 935.8 937.9 938.5 939.1 954.8 955.2 955.2 955.4 956.8 1019.2 1030.5 1033.0 1033.1 1033.2 1016.5 1021.5 1027.3 1028.3 1030.6 722.5 734.2 736.0 745.4 746.8 20282.7 20461.1 20466.2 20471.3 20486.7 21215.8 21717.5 22525.3 22761.8 22791.1 17710.8 17875.5 17884.4 17912.5 17991.3 3824.3 3852.9 3854.2 3857.8 3859.1 146777.0 146780.0 147905.3 149861.0 152995.0 16701.8 16932.6 17041.3 17081.6 17090.9 31963.8 32255.5 32428.8 32441.7 32495.7 8613.6 8712.6 8749.9 8785.2 8923.1 4136.2 4212.4 4227.5 4230.2 4258.8 5202.6 5287.5 5302.0 5326.2 5331.5 970.9 1015.9 1029.4 1038.2 1052.4 692.0 710.5 710.8 711.9 717.5 10755.2 11082.9 11279.7 11622.5 12191.2 671.9 690.4 696.4 714.1 717.3 5350.2 5391.5 5449.3 5453.8 5561.4 125968.4 128132.0 129104.0 130361.0 132628.0 107558.0 108690.0 109347.0 109481.5 110518.4 95034.0 98983.0 99539.0 99809.0 102062.5 9881.0 9978.8 10026.3 10045.3 10087.7 42964.8 43569.8 43810.0 45088.0 45157.8 57155.0 57451.4 59001.1 59055.0 59227.7 13649.0 13726.9 13797.8 13919.9 13932.9 16629.8 16679.7 16881.0 16904.0 17010.1 15561.2 15598.2 15614.8 15656.4 15823.4 13554.5 13628.1 13779.2 13818.2 13838.5 14802.6 14839.6 14980.3 14985.3 15137.3 10685.7 11092.2 11126.9 11237.9 11348.1 10457.9 10506.9 10572.2 10872.4 10929.8 14:58:02 INFO - PID 5311 | -------- Summary: end -------- 14:58:02 INFO - PID 5311 | 14:58:02 INFO - TEST-INFO | 5311: exit 0 14:58:02 INFO - TEST-OK | dromaeo_css | took 1108399ms 14:58:02 INFO - TEST-START | kraken 14:58:02 INFO - Initialising browser for kraken test... 14:58:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44243/getInfo.html -profile /tmp/tmpgSRk_l/profile 14:58:02 INFO - TEST-INFO | started process 5686 (/builds/slave/test/build/application/firefox/firefox http://localhost:44243/getInfo.html) 14:58:07 INFO - TEST-INFO | 5686: exit 0 14:58:07 INFO - Browser initialized. 14:58:07 INFO - Running cycle 1/1 for kraken test... 14:58:07 INFO - Using env: {'DISPLAY': ':0', 14:58:07 INFO - 'HOME': '/home/cltbld', 14:58:07 INFO - 'JSGC_DISABLE_POISONING': '1', 14:58:07 INFO - 'LANG': 'en_US.UTF-8', 14:58:07 INFO - 'LANGUAGE': 'en_US:en', 14:58:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:58:07 INFO - 'LOGNAME': 'cltbld', 14:58:07 INFO - 'MAIL': '/var/mail/cltbld', 14:58:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:58:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:58:07 INFO - 'MOZ_CRASHREPORTER': '1', 14:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:58:07 INFO - 'MOZ_NO_REMOTE': '1', 14:58:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:07 INFO - 'NO_EM_RESTART': '1', 14:58:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:07 INFO - 'PWD': '/builds/slave/test', 14:58:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:58:07 INFO - 'RUST_BACKTRACE': 'full', 14:58:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:58:07 INFO - 'SHELL': '/bin/bash', 14:58:07 INFO - 'SHLVL': '1', 14:58:07 INFO - 'TERM': 'linux', 14:58:07 INFO - 'TMOUT': '86400', 14:58:07 INFO - 'USER': 'cltbld', 14:58:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066', 14:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:07 INFO - '_': '/tools/buildbot/bin/python'} 14:58:07 INFO - TEST-INFO | started process 5919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSRk_l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:08 INFO - PID 5919 | 14:58:08 INFO - PID 5919 | (/builds/slave/test/build/application/firefox/firefox:5968): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:58:08 INFO - PID 5919 | 14:58:19 INFO - PID 5919 | RSS: Main: 156971008 14:58:19 INFO - PID 5919 | 14:58:21 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44243/tests/kraken/driver.html?testName=audio-beat-detection) 14:58:22 INFO - PID 5919 | RSS: Main: 163258368 14:58:22 INFO - PID 5919 | 14:58:25 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44243/tests/kraken/driver.html?testName=audio-dft) 14:58:25 INFO - PID 5919 | RSS: Main: 162791424 14:58:25 INFO - PID 5919 | 14:58:28 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44243/tests/kraken/driver.html?testName=audio-fft) 14:58:29 INFO - PID 5919 | RSS: Main: 159285248 14:58:29 INFO - PID 5919 | 14:58:31 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44243/tests/kraken/driver.html?testName=audio-oscillator) 14:58:32 INFO - PID 5919 | RSS: Main: 159748096 14:58:32 INFO - PID 5919 | 14:58:34 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:58:34 INFO - PID 5919 | RSS: Main: 159756288 14:58:34 INFO - PID 5919 | 14:58:38 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44243/tests/kraken/driver.html?testName=imaging-darkroom) 14:58:38 INFO - PID 5919 | RSS: Main: 161550336 14:58:38 INFO - PID 5919 | 14:58:42 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44243/tests/kraken/driver.html?testName=imaging-desaturate) 14:58:42 INFO - PID 5919 | RSS: Main: 162009088 14:58:42 INFO - PID 5919 | 14:58:45 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44243/tests/kraken/driver.html?testName=json-parse-financial) 14:58:46 INFO - PID 5919 | RSS: Main: 161996800 14:58:46 INFO - PID 5919 | 14:58:48 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:58:48 INFO - PID 5919 | RSS: Main: 162263040 14:58:48 INFO - PID 5919 | 14:58:50 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:58:50 INFO - PID 5919 | RSS: Main: 162328576 14:58:50 INFO - PID 5919 | 14:58:53 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:58:53 INFO - PID 5919 | RSS: Main: 158650368 14:58:53 INFO - PID 5919 | 14:58:56 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:58:56 INFO - PID 5919 | RSS: Main: 159584256 14:58:56 INFO - PID 5919 | 14:58:59 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:00 INFO - PID 5919 | RSS: Main: 159318016 14:59:00 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | Cycle 1(1): loaded http://localhost:44243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44243/tests/kraken/driver.html?testName=ai-astar) 14:59:02 INFO - PID 5919 | RSS: Main: 160923648 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | __start_tp_report 14:59:02 INFO - PID 5919 | _x_x_mozilla_page_load 14:59:02 INFO - PID 5919 | _x_x_mozilla_page_load_details 14:59:02 INFO - PID 5919 | |i|pagename|runs| 14:59:02 INFO - PID 5919 | |0;ai-astar;108;106;106;106;111;107;107;106;108;109 14:59:02 INFO - PID 5919 | |1;audio-beat-detection;119;117;116;114;116;121;116;115;117;116 14:59:02 INFO - PID 5919 | |2;audio-dft;162;165;163;164;163;162;163;164;165;171 14:59:02 INFO - PID 5919 | |3;audio-fft;74;75;74;74;73;74;76;75;75;74 14:59:02 INFO - PID 5919 | |4;audio-oscillator;80;79;80;79;79;79;79;79;80;79 14:59:02 INFO - PID 5919 | |5;imaging-gaussian-blur;114;113;113;114;118;115;113;114;114;116 14:59:02 INFO - PID 5919 | |6;imaging-darkroom;147;148;147;147;148;149;149;148;149;149 14:59:02 INFO - PID 5919 | |7;imaging-desaturate;94;93;93;93;94;94;93;94;93;95 14:59:02 INFO - PID 5919 | |8;json-parse-financial;59;56;55;53;54;54;55;55;55;55 14:59:02 INFO - PID 5919 | |9;json-stringify-tinderbox;38;38;37;38;38;37;39;39;38;38 14:59:02 INFO - PID 5919 | |10;stanford-crypto-aes;75;74;77;72;72;73;74;74;73;74 14:59:02 INFO - PID 5919 | |11;stanford-crypto-ccm;110;118;113;112;112;114;111;114;114;112 14:59:02 INFO - PID 5919 | |12;stanford-crypto-pbkdf2;168;167;164;183;167;172;177;178;177;171 14:59:02 INFO - PID 5919 | |13;stanford-crypto-sha256-iterative;67;68;65;69;64;64;64;66;68;76 14:59:02 INFO - PID 5919 | __end_tp_report 14:59:02 INFO - PID 5919 | __start_cc_report 14:59:02 INFO - PID 5919 | _x_x_mozilla_cycle_collect,742 14:59:02 INFO - PID 5919 | __end_cc_report 14:59:02 INFO - PID 5919 | __startTimestamp1505599142538__endTimestamp 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | ------- Summary: start ------- 14:59:02 INFO - PID 5919 | Number of tests: 14 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#0] ai-astar Cycles:10 Average:107.40 Median:107.50 stddev:1.65 (1.5%) stddev-sans-first:1.73 14:59:02 INFO - PID 5919 | Values: 108.0 106.0 106.0 106.0 111.0 107.0 107.0 106.0 108.0 109.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#1] audio-beat-detection Cycles:10 Average:116.70 Median:116.50 stddev:2.00 (1.7%) stddev-sans-first:1.94 14:59:02 INFO - PID 5919 | Values: 119.0 117.0 116.0 114.0 116.0 121.0 116.0 115.0 117.0 116.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.62 (1.6%) stddev-sans-first:2.65 14:59:02 INFO - PID 5919 | Values: 162.0 165.0 163.0 164.0 163.0 162.0 163.0 164.0 165.0 171.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 14:59:02 INFO - PID 5919 | Values: 74.0 75.0 74.0 74.0 73.0 74.0 76.0 75.0 75.0 74.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 14:59:02 INFO - PID 5919 | Values: 80.0 79.0 80.0 79.0 79.0 79.0 79.0 79.0 80.0 79.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 14:59:02 INFO - PID 5919 | Values: 114.0 113.0 113.0 114.0 118.0 115.0 113.0 114.0 114.0 116.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 14:59:02 INFO - PID 5919 | Values: 147.0 148.0 147.0 147.0 148.0 149.0 149.0 148.0 149.0 149.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:59:02 INFO - PID 5919 | Values: 94.0 93.0 93.0 93.0 94.0 94.0 93.0 94.0 93.0 95.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.60 (2.9%) stddev-sans-first:0.87 14:59:02 INFO - PID 5919 | Values: 59.0 56.0 55.0 53.0 54.0 54.0 55.0 55.0 55.0 55.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.71 14:59:02 INFO - PID 5919 | Values: 38.0 38.0 37.0 38.0 38.0 37.0 39.0 39.0 38.0 38.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:1.48 (2.0%) stddev-sans-first:1.50 14:59:02 INFO - PID 5919 | Values: 75.0 74.0 77.0 72.0 72.0 73.0 74.0 74.0 73.0 74.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:113.50 stddev:2.21 (1.9%) stddev-sans-first:2.06 14:59:02 INFO - PID 5919 | Values: 110.0 118.0 113.0 112.0 112.0 114.0 111.0 114.0 114.0 112.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:174.50 stddev:6.11 (3.5%) stddev-sans-first:6.27 14:59:02 INFO - PID 5919 | Values: 168.0 167.0 164.0 183.0 167.0 172.0 177.0 178.0 177.0 171.0 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:3.63 (5.4%) stddev-sans-first:3.86 14:59:02 INFO - PID 5919 | Values: 67.0 68.0 65.0 69.0 64.0 64.0 64.0 66.0 68.0 76.0 14:59:02 INFO - PID 5919 | -------- Summary: end -------- 14:59:02 INFO - PID 5919 | 14:59:02 INFO - PID 5919 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:59:03 INFO - TEST-INFO | 5919: exit 0 14:59:03 INFO - TEST-OK | kraken | took 60456ms 14:59:03 INFO - SUITE-END | took 1168s 14:59:03 INFO - Completed test suite (00:19:28) 14:59:03 INFO - javascript benchmark 14:59:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8639.642177036942, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.642802863654, 3103.627564692236, 3121.0, 3145.8269795161273, 3160.336329370832, 6334.809955701325, 6367.840803979902, 6382.138411314471, 6415.679216039202, 6422.807315780522, 6178.104174894649, 6237.438630523252, 6286.874262514747, 6291.811245662638, 6300.991841305392, 5769.019266724646, 5782.508486778629, 5827.766889324422, 5847.473727364536, 5870.442307980735, 1344.1471429082567, 5850.444207800252, 5906.4093590640805, 5917.378675239102, 5948.851278718023, 5736.110902810071, 5752.252207213057, 5823.79616713413, 5866.296044474648, 5883.029300165467, 5764.16419619157, 5788.855278618068, 5862.999999999957, 5864.941350586525, 5878.118282257653, 5747.655140691572, 5771.797987070432, 5810.738516766755, 5842.386549412293, 5844.620099693549, 6275.403836635513, 6296.929521981228, 6315.905261421082, 6398.232212134527, 6399.552031357807, 6727.29363416844, 6780.254172041072, 6804.455643548505, 6841.555298905605, 6865.656717164122, 6838.350356716104, 6840.794776156723, 6868.759593414206, 6876.415504682108, 6878.518503704742, 6282.87434251317, 6298.212723409574, 6330.905036424458, 6366.77716279928, 6372.968135159341, 6967.198772141269, 6977.406920411822, 6983.196932352743, 7064.798984172703, 7069.717211311593, 6624.966875165594, 6639.336066393322, 6702.463802895757, 6714.294999025032, 6722.29415911332, 6786.830329241809, 6818.977153426927, 6843.931560684329, 6845.863082738417, 6848.589084654936, 6704.765333213411, 6737.932620673829, 6741.1910570731825, 6783.966080169567, 6794.626295553792, 6718.05947167397, 6742.898856517156, 6758.357955994173, 6869.347411995853, 6878.7248510060035, 5250.369955605275, 5272.6836389816735, 5273.31446911899, 5283.920741188886, 5294.97352513235, 4616.3537104805355, 4623.86128416148, 4627.722336659811, 4635.837745678885, 4640.373549570832, 5821.970890145522, 5834.066549352168, 5879.559033072536, 5887.8233652990475, 5888.175655408247, 6806.183258008971, 6806.625635589991, 6875.5530890491955, 6883.483738719616, 6889.689963951634, 5813.56398270123, 5826.213461182686, 5884.676342801187, 5897.2038774765715, 5905.025670764362, 5676.375598684142, 5741.540676745851, 5741.684207368551, 5745.425457454305, 5747.879163563149, 6495.155629768195, 6531.118299029666, 6588.8023359299295, 6603.669816509156, 6617.305182955816, 6781.728730850711, 6853.623050732258, 6858.142732158481, 6861.348171923659, 6875.140607424072, 6494.4804415645685, 6498.252700939453, 6519.1199188110895, 6588.40704336612, 6600.339966003361, 6529.249136349191, 6672.132622759011, 6695.698693558704, 6724.798256052326, 6749.291324410866, 6837.179538455417, 6865.27914568983, 6906.274841141608, 6931.584104953719, 6939.930600693929, 6515.771947981798, 6542.8364290893105, 6559.048937903882, 6631.171103612049, 6637.834054148685, 6433.453156481564, 6532.738690452328, 6575.342465753386, 6644.767433139817, 6662.433693136138, 6442.581232219891, 6446.871062578628, 6456.6771661415805, 6458.192725909262, 6458.451031662174, 6494.09082728409, 6591.110200122922, 6592.077109204619, 6592.934070659424, 6701.530892837454, 6411.358864113738, 6411.711472983634, 6488.643124628191, 6501.44737697301, 6518.185226846645], "value": 6141.928634822378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.2214995429136, 884.0982198157877, 886.4415418286478, 890.2210565754964, 891.2825175733532, 37755.0, 40883.18233635329, 41314.38028429569, 41390.379144312785, 41409.79295103528, 38403.615963840355, 38670.0, 38713.806430967874, 38761.0, 38858.417123743166, 7020.613866237355, 7121.715131394738, 7132.215456299803, 7655.119661238945, 7873.25204105609, 7757.961210193969, 7865.921340786576, 7870.252326029018, 7870.842583148334, 7871.960640196819, 7787.844243115134, 7828.373730101578, 7831.0, 7893.250141236602, 7902.3678105751405, 7774.650140743652, 7826.413019023567, 7839.098503672037, 7840.411969102283, 7842.411819113589, 7718.0, 7806.72676456327, 7809.101953275389, 7814.3357814585825, 7815.804604884866, 37579.81210093932, 37891.62108378908, 37924.24151516954, 37941.43087853684, 37947.620523794685, 3472.5659292588425, 3505.2113274513285, 3509.877154299613, 3511.7015053720465, 3516.1736991806906, 30813.845930770425, 30931.381372372653, 31016.0, 31055.689443105504, 31113.22216944572, 5069.923951140736, 5132.332796736438, 5200.817971370984, 5209.192575150858, 5290.735463226823, 191812.0, 192505.0, 192739.0, 192903.0, 193153.03423482933, 42774.0, 43287.134257314676, 49454.50545494571, 49509.257361139615, 49572.75213623909, 44609.77695111504, 51053.0, 51430.74284628553, 51693.22460163101, 51834.48165518372, 15977.360905563879, 16009.359625614845, 16124.193790310437, 16154.515364539082, 16169.514914552583, 13152.342382880817, 13209.669758255928, 13262.469501220035, 13274.601761947157, 13282.66793330155, 14158.575242742734, 14198.0, 14289.92855035739, 14310.85689143116, 14429.0, 5782.739776709974, 5825.88348233033, 5845.883082338414, 5861.1537365729655, 5910.320313164041, 985.935914165577, 999.8500224966314, 1002.2733518199248, 1016.1159790981745, 1021.8569400283966, 22107.778922210895, 22379.104835806385, 22754.544909102056, 22824.885875570515, 23102.65346019811, 1078.2075174746556, 1093.420487141816, 1100.1748688483638, 1100.5542755184163, 1120.5125770289949, 11886.762264754829, 11930.284182949052, 11978.041756659446, 12011.279323240633, 12096.274223546616, 234385.0, 235319.0, 235751.0, 236053.0, 236450.0, 50994.74502627463, 51152.976940461725, 54726.452735472136, 55799.0, 55836.72081639566, 1388.1809732258016, 1415.8867290616931, 1418.6027912184604, 1433.1616004637197, 1454.4909281751513, 26406.603900941886, 26575.468490629693, 26710.332241694112, 27035.72964270332, 27517.31206719848, 37611.43582846205, 37740.81129594334, 37768.62231377651, 37804.2439151221, 37846.62153378431, 192395.0, 194520.0, 195092.0, 195391.0, 195889.0, 33273.16817079592, 35452.46821297734, 36168.0, 36180.27639447249, 36220.0, 45447.77276113598, 45696.31455528103, 45832.7708361456, 45897.54102458933, 45955.0, 33587.49618755769, 34048.319033619686, 34105.48841767326, 34367.65632343745, 34405.655943440244, 33526.329473410886, 33621.66378336185, 33633.83183084167, 33847.492287616195, 34272.314553709286, 36267.81866090652, 37712.81143594265, 37811.432828507044, 37856.43215351827, 38284.2343153141, 32433.675663243066, 32502.51246231261, 33022.0, 33501.32997340088, 33560.328793423505, 23743.525129496968, 24507.63238551459, 24998.75001249964, 25576.0, 25662.230133096036], "value": 17340.67278073952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5529293625694, 554.9805756798513, 559.3036669346661, 577.1487056591528, 583.6060659055138, 22689.54620907583, 23693.881530592324, 23786.88106559469, 23805.404864878386, 23808.999999999978, 23502.294931152093, 24572.139975100876, 24599.63100553493, 24848.75151248487, 25020.624690629655, 6420.839479013027, 6517.315681853408, 6520.9673951630175, 6543.3783790540065, 6555.541112122153, 6420.357964203566, 6519.282878883319, 6527.608343499382, 6543.443807276387, 6733.528652994292, 6935.271796461375, 6999.720011199546, 7085.2914708529, 7088.610126443069, 7089.71641134354, 7023.929760702379, 7063.328983746535, 7093.219745827955, 7094.858102837914, 7102.1832489263625, 6925.826854328631, 6940.514164008521, 6946.444284457282, 6953.304669533057, 6964.4428445724225, 28829.42341153165, 29173.708262917313, 29980.0, 30230.24424389386, 30480.8475957621, 2027.168860767093, 2046.3451695457459, 2054.137262349817, 2054.6404379233722, 2054.9280775172797, 20207.797922020887, 20902.268420605207, 20920.267790627255, 20967.895160524098, 21016.474588135265, 2450.8529488230765, 2519.3071905226025, 2580.0324878170686, 2587.2884956636885, 2607.413332000304, 128970.3551482246, 137264.0, 138038.30980845133, 141879.99999999898, 146651.0, 20408.59182816365, 21106.155753769985, 21303.68044479334, 21666.783332166477, 22319.776802232096, 43185.56814431815, 43344.566554334684, 43373.56626433758, 43442.34836477455, 43490.782546087066, 11384.715382115513, 11455.885441145649, 11483.42582870853, 11483.942580287045, 11845.170838041427, 9701.757456063513, 9733.172680322252, 9781.217502599775, 9826.0, 9832.557534910946, 11162.772095069537, 11225.270357426742, 11339.773204535863, 11397.373144477133, 11422.885771142182, 4000.6599439047427, 4038.273110840018, 4124.876253712393, 4139.81370838307, 4171.581662234855, 952.3952290295574, 969.9669851608015, 979.480875136179, 989.9010098990043, 1001.0, 19073.904630476758, 19248.518787030436, 19274.421767347, 19284.1322140504, 19817.810931344164, 1041.7239431550645, 1042.7810159866513, 1046.1473898772476, 1051.6582110813863, 1053.625962783201, 10471.361127070046, 10836.133109351233, 10845.891541084646, 10960.561577536968, 11065.612703555336, 459488.0, 463165.0, 467631.0, 468459.0, 490214.0, 111802.0, 112437.43781281204, 115558.42220788842, 117160.41419792846, 117555.0, 1033.7984093101772, 1077.7790552936629, 1164.5923926625783, 1188.5602327139013, 1219.4329636718792, 19749.70375444398, 19846.90076549666, 20065.197392104736, 20175.293864714666, 20284.695729563773, 54457.72771136119, 54575.454245458626, 54872.45127548673, 55622.775088995986, 56598.71700641471, 67682.0, 68128.3187168122, 69365.65317173382, 70171.29828701852, 70651.64674176596, 19359.3224237151, 19832.20671173137, 20074.0, 20095.19619215215, 20444.97775111268, 22312.66531002004, 22515.88742056279, 22536.774632254124, 22551.436214094778, 22586.661200081682, 18101.818981810015, 18260.543486412946, 18284.268629254682, 18392.172352244448, 18418.35535756242, 16262.268197931358, 16511.504654860375, 16601.584960376087, 16948.491545253662, 17072.914635426743, 17985.280588776302, 18765.530861728566, 18825.811741882408, 19086.522836929187, 19097.949612770874, 19515.0, 19667.901660491607, 19808.70286945668, 19872.60254794867, 19877.900610496854, 17887.642247155243, 18079.548011299823, 18229.908850456195, 18398.908005460424, 18404.895706257666], "value": 12906.018244363575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.3307079924637, 1367.7948307753843, 1370.8217931668885, 1386.126740153703, 1386.6325423762705, 14970.401183952628, 15664.295106720196, 15683.843161568395, 15686.294116764744, 15720.0, 15134.848651513481, 15378.769318460232, 15386.923065384686, 15389.076655400684, 15414.0, 2696.3663539068352, 2808.4102338508837, 2813.1701148161237, 2814.704456032118, 2816.3381605322734, 2654.1241390341143, 2700.054980756739, 2705.5130076586206, 2720.7687346575567, 2723.3872378714827, 2671.185288487011, 2678.825876318043, 2694.676638803346, 2696.0294294054124, 2698.109623824143, 2593.597992311195, 2621.2398404462683, 2629.421527263999, 2630.18464276075, 2641.0492222799776, 2521.773040426352, 2553.527597394488, 2563.9615405768927, 2681.316264352597, 2730.808843380964, 14894.0, 14947.40210391583, 14950.47673331439, 14985.250737463191, 15009.849901501064, 8009.439339246255, 8331.041930178046, 8339.83320333596, 8343.749687509384, 8349.749507514784, 5230.0, 5351.678899266057, 5600.271964644611, 5639.830805075854, 5747.166660834156, 1834.4863438237314, 1858.628274345123, 1899.5441094137445, 1930.7683078030586, 1934.1586409911592, 26970.730292697215, 27056.59415108775, 27244.31889202766, 27282.31794205121, 27329.31676708098, 7307.525010874382, 7369.594672292968, 7612.373731062775, 7632.1986191450205, 7668.961655191688, 17262.65474690499, 17332.393366232373, 17357.7396339055, 17361.392351267645, 17370.739438908426, 8023.518588884685, 8166.224208700164, 8179.222973817477, 8181.18188181189, 8184.754457366289, 7465.514741541782, 7496.512726672749, 7542.962285188539, 7605.429592780563, 7613.124490683642, 5031.597472202288, 5153.5361817436615, 5206.479352064764, 5245.790168393298, 5331.653442526223, 1351.8242628458238, 1386.4939297156666, 1474.550262170027, 1489.5903626502798, 1549.806274215723, 906.9727908162765, 915.3592485260211, 927.7819712367589, 930.7766136127416, 939.4926739560698, 7980.281774640311, 8037.919620803717, 8144.755657330171, 8186.222308880766, 8305.169483051768, 981.6760469045198, 992.176493510399, 997.65082221222, 1003.9297249192487, 1023.9795204096025, 5281.973590132025, 5421.864453388697, 5455.399906010336, 5504.944950550524, 5526.198701188305, 21011.684824727643, 22052.448688782908, 22255.0, 22288.219912302993, 22301.88849055777, 21011.8949405252, 21904.0, 22006.559868802535, 22110.0, 22361.664575031387, 11323.094152467782, 11484.0, 11510.194286399872, 11520.193586449035, 11567.479463424166, 8165.305948994402, 8229.300509456763, 8240.21717936795, 8337.416380853281, 8402.369822263232, 18974.810251897303, 19094.0, 19379.0, 19395.709064363764, 19446.513837154183, 19073.0, 19180.232790688773, 19310.8068919309, 19916.800831992074, 19923.501912452306, 10914.50884710174, 11119.054880335261, 11126.276792008493, 11134.164937629872, 11139.72150696239, 13920.58238252854, 14049.929750351183, 14052.297385130907, 14113.2943352834, 14205.786913196516, 10884.945575272073, 11525.711857203636, 11552.364619945984, 11774.3524106175, 12074.0, 10393.740156495845, 10643.521041553304, 10671.46642667879, 10808.513616887101, 10974.231803773979, 10029.348092373972, 10320.48397580133, 10322.0, 10453.47732613351, 10462.895371046496, 7220.602866842374, 7381.889271660822, 7410.62946852666, 7428.925710742823, 7487.47587668858, 6971.6862741175755, 6987.580745155307, 7046.718131274692, 7087.291270872872, 7110.43116550685], "value": 6744.726161320766, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.2779156327544, 500.03676740936845, 516.3855012535081, 518.8858451140749, 520.4535238000101, 6144.662043587601, 6184.56708030438, 6191.50467962563, 6265.843353916149, 6278.399008252901, 6168.876622467559, 6221.937780622193, 6265.467435267997, 6284.072454715802, 6290.559660823744, 5148.871278218046, 5170.819021334254, 5214.217867319894, 5220.373555173384, 5236.109861323565, 4914.361133052698, 5021.347224860763, 5026.371703537058, 5071.873203169932, 5196.766145523442, 5011.198208286675, 5052.444231134591, 5057.974710126444, 5063.74681265937, 5072.137736584789, 4972.801087956495, 4988.700677959316, 5029.84910452687, 5034.144195486776, 5041.899162016776, 4480.6191473724775, 4519.389882365905, 4534.13851368239, 4543.909121817545, 4552.908941821178, 6217.347178546278, 6235.563510554263, 6241.251049873998, 6268.934281172212, 6285.340039295854, 5656.8905581971785, 5697.373288938214, 5704.22992895962, 5770.826875193751, 5791.175779629403, 6537.5750576212395, 6571.441427478622, 6621.172353455818, 6637.966810165966, 6647.86704265912, 4925.729084900329, 4944.629152813553, 4954.9752251238515, 4963.528464795839, 4970.353853998993, 7006.369426751617, 7030.718771249195, 7052.188998265163, 7078.92921070793, 7094.787156385317, 5005.549500544968, 5006.973570418056, 5029.119904016782, 5032.647714659939, 5040.899182016413, 5116.718580478035, 5131.512506311894, 5136.871578210575, 5141.074606570854, 5153.587712982952, 5754.4533269339345, 5755.424457554211, 5763.164341170507, 5772.336181339116, 5784.016717158093, 6322.683865806691, 6642.535022548472, 6645.900311495331, 6648.202215734046, 6668.599884006975, 1632.6244963658426, 1688.240291868664, 1744.8778585498894, 1760.5862622283753, 1761.2250609731677, 1197.3115458611333, 1216.47691492659, 1217.15407791584, 1233.3586535001748, 1234.6542967968983, 5505.614606977473, 5666.575006874501, 5688.601797874109, 5719.971400142973, 5721.971390143022, 6589.242237142694, 6641.833954151089, 6703.932960670429, 6788.830279243059, 6848.589084654936, 5717.342505611908, 5787.826365209051, 5793.362730099686, 5795.333536643256, 5833.67914764692, 3548.6628770266784, 3551.5205447264807, 3583.6416358364477, 3610.530631017951, 3618.16782140104, 6548.377904099103, 6562.967185164139, 6577.769778057841, 6590.0, 6606.933930660728, 6988.266232045664, 6998.265182155902, 7007.544509606859, 7016.5790052595985, 7078.221395646475, 6455.2253729553695, 6501.739930402826, 6520.576162549419, 6556.442702370352, 6596.340365963365, 6689.264180939996, 6757.93242067573, 6766.7969960901255, 6784.626845523544, 6838.658067096725, 6663.233728121134, 6680.766173183915, 6701.530892837454, 6719.193696756421, 6737.326267373223, 6457.289698133295, 6482.384173503509, 6522.510811689048, 6588.670566471753, 6647.401733843977, 4978.029284289529, 4986.15235409974, 5002.199648056294, 5014.648974571891, 5023.0, 6342.175517182736, 6555.3772391622715, 6638.203415589967, 6712.429443497357, 6768.932310677027, 6158.815235542941, 6424.38968298011, 6454.903176452263, 6466.612003279818, 6592.373724496357, 6387.552871298964, 6496.9025464617125, 6508.902366464602, 6519.445847103049, 6548.3124271950755, 6339.084021350046, 6381.1704478417505, 6383.904241436475, 6492.123563318892, 6495.707693153914, 6518.902216466851, 6529.967350163219, 6580.901286480803, 6616.106825578485, 6671.097408016365, 6426.4537514311805, 6427.196600424947, 6430.421262086435, 6465.321141280286, 6465.482761379172], "value": 5084.6770572998485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.4096896048609, 903.5121034641294, 919.4988731141527, 929.7303781903248, 930.0792215706448, 18263.45209643711, 19081.0, 19092.61814763704, 19099.140538675758, 19151.99999999998, 17564.59703043505, 17821.108944552787, 18110.0, 18763.15565799539, 18838.43484695458, 930.8510638297873, 935.7894473743421, 937.8921424036221, 938.4744543055876, 939.0562484702864, 954.8424509955848, 955.1737746848995, 955.2024059909984, 955.4028732042474, 956.8277710012195, 1019.2152042926941, 1030.5002073994144, 1032.989670103297, 1033.0702367868942, 1033.1631378583334, 1016.5019140621042, 1021.5045702834119, 1027.2706378471257, 1028.2647906746674, 1030.6238223048572, 722.5159143373952, 734.1740541890373, 736.0321177651372, 745.4334705623711, 746.8058304840727, 20282.69575956362, 20461.079251433723, 20466.181352745873, 20471.283505077252, 20486.692699609517, 21215.78784212169, 21717.45706357338, 22525.324240272817, 22761.77238227613, 22791.08835646572, 17710.822891771048, 17875.463736087808, 17884.374046908295, 17912.462626121105, 17991.280348786033, 3824.330742120118, 3852.9211820690252, 3854.209886973164, 3857.8263978121054, 3859.112404147034, 146777.0, 146780.0, 147905.26047369695, 149861.0, 152995.0, 16701.83298167027, 16932.57668558296, 17041.318347266217, 17081.572960675832, 17090.914545427193, 31963.840180798947, 32255.51616725751, 32428.83785581104, 32441.675583244338, 32495.675043249266, 8613.61238744258, 8712.564371781385, 8749.91250087491, 8785.209331160098, 8923.107689231025, 4136.21411931732, 4212.410262563244, 4227.534971153171, 4230.175115852379, 4258.808353624095, 5202.583793296603, 5287.4976877196605, 5301.973490132602, 5326.201069839555, 5331.5201631853315, 970.9126178643955, 1015.9288849780593, 1029.3875144289136, 1038.159091136182, 1052.4001319247955, 691.9827004324932, 710.4529512275519, 710.8084699698318, 711.9181294151135, 717.5300178383168, 10755.193360497993, 11082.944585277022, 11279.718007049725, 11622.476988535536, 12191.207571507824, 671.9462443004547, 690.413148823496, 696.4045740891567, 714.0752725220748, 717.2683862460261, 5350.224217488442, 5391.460853914656, 5449.264349312792, 5453.836384908459, 5561.443855614487, 125968.37015814862, 128132.0, 129104.0, 130361.0, 132628.0, 107558.0, 108690.0, 109347.0, 109481.45259273653, 110518.44740776245, 95034.0, 98983.0, 99538.99999999854, 99809.0, 102062.48968755257, 9880.950595246977, 9978.750531236778, 10026.348287361297, 10045.296829221885, 10087.69736907894, 42964.78517607392, 43569.78215108904, 43810.0, 45088.0, 45157.77421113005, 57155.0, 57451.42548574628, 59001.11498327443, 59055.0, 59227.70386148042, 13649.0, 13726.931365343109, 13797.79303310431, 13919.88640908745, 13932.860671393157, 16629.833701663312, 16679.749803753195, 16881.0, 16904.0, 17010.064446455563, 15561.221938902783, 15598.220088995731, 15614.84385156134, 15656.37374505007, 15823.367065317258, 13554.525591604246, 13628.114172578751, 13779.242141682304, 13818.170909745448, 13838.515651952133, 14802.62993425173, 14839.629009274855, 14980.325885334969, 14985.325660345092, 15137.318820652878, 10685.679429616814, 11092.168087393638, 11126.944365278121, 11237.887621124011, 11348.148888833206, 10457.9477102614, 10506.896775838733, 10572.20708446885, 10872.402017889091, 10929.836052459379], "value": 8821.796388319503, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 106.0, 106.0, 111.0, 107.0, 107.0, 106.0, 108.0, 109.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 116.0, 114.0, 116.0, 121.0, 116.0, 115.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 164.0, 163.0, 162.0, 163.0, 164.0, 165.0, 171.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 74.0, 73.0, 74.0, 76.0, 75.0, 75.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 118.0, 115.0, 113.0, 114.0, 114.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 149.0, 149.0, 148.0, 149.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 95.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 55.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 39.0, 39.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 72.0, 72.0, 73.0, 74.0, 74.0, 73.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 113.0, 112.0, 112.0, 114.0, 111.0, 114.0, 114.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 164.0, 183.0, 167.0, 172.0, 177.0, 178.0, 177.0, 171.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 69.0, 64.0, 64.0, 64.0, 66.0, 68.0, 76.0], "value": 67.1, "unit": "score"}]}]} 14:59:03 INFO - Return code: 0 14:59:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:59:03 INFO - # TBPL SUCCESS # 14:59:03 INFO - Running post-action listener: _package_coverage_data 14:59:03 INFO - Running post-action listener: _resource_record_post_action 14:59:03 INFO - [mozharness: 2017-09-16 21:59:03.310625Z] Finished run-tests step (success) 14:59:03 INFO - Running post-run listener: _resource_record_post_run 14:59:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 325488640; Read time: 172; Write time: 298172 14:59:03 INFO - TinderboxPrint: CPU usage
13.1% 14:59:03 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 172 14:59:03 INFO - TinderboxPrint: I/O write bytes / time
325,488,640 / 298,172 14:59:03 INFO - TinderboxPrint: CPU idle
8,222.2 (86.9%) 14:59:03 INFO - TinderboxPrint: CPU user
1,190.3 (12.6%) 14:59:03 INFO - TinderboxPrint: Swap in / out
0 / 0 14:59:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 901120; Read time: 0; Write time: 52 14:59:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:59:03 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324587520; Read time: 160; Write time: 298120 14:59:03 INFO - Running post-run listener: _upload_blobber_files 14:59:03 INFO - Blob upload gear active. 14:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:03 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 14:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:59:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:05 INFO - (blobuploader) - INFO - Done attempting. 14:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:06 INFO - (blobuploader) - INFO - Done attempting. 14:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:07 INFO - (blobuploader) - INFO - Done attempting. 14:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:14 INFO - (blobuploader) - INFO - Done attempting. 14:59:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:14 INFO - Return code: 0 14:59:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52cbd909e1df4e7766dd398967f68c01b44c55bdb559a1b075a17b62c69fda7eb53e4de5e7b6a9f20bb61f377c00c4b1ca4e32768cea76255107ac4a077a3fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccc0ff3373296f42c8209e5f2389b18df2459973049b768621b9993cf626a9414aeb1612f5fdb9df6bb17914f022191229de4072b2c4b98f33534a4b4bd70f6c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e333dd2380931aced0e9b05cc5122ed3256f39ce9faf065927d9429c5f7e4e47cf1f8213d81888ff51f1c75889bf52c59ecbc5f88af10c1b47227728b66c0e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0ab5eba7d0bc5f56541205000eacee80e1dfd87de5baf0ce0a03cb2239d7d57ccef607ffb3abbed818300764065d7b79706cebdde7ff84ca8502291e94e64b"} 14:59:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:14 INFO - Contents: 14:59:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52cbd909e1df4e7766dd398967f68c01b44c55bdb559a1b075a17b62c69fda7eb53e4de5e7b6a9f20bb61f377c00c4b1ca4e32768cea76255107ac4a077a3fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccc0ff3373296f42c8209e5f2389b18df2459973049b768621b9993cf626a9414aeb1612f5fdb9df6bb17914f022191229de4072b2c4b98f33534a4b4bd70f6c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e333dd2380931aced0e9b05cc5122ed3256f39ce9faf065927d9429c5f7e4e47cf1f8213d81888ff51f1c75889bf52c59ecbc5f88af10c1b47227728b66c0e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0ab5eba7d0bc5f56541205000eacee80e1dfd87de5baf0ce0a03cb2239d7d57ccef607ffb3abbed818300764065d7b79706cebdde7ff84ca8502291e94e64b"} 14:59:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:14 INFO - Copying logs to upload dir... 14:59:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.614455 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 14:59:14.091173) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 14:59:14.099615) ========= 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=920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52cbd909e1df4e7766dd398967f68c01b44c55bdb559a1b075a17b62c69fda7eb53e4de5e7b6a9f20bb61f377c00c4b1ca4e32768cea76255107ac4a077a3fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccc0ff3373296f42c8209e5f2389b18df2459973049b768621b9993cf626a9414aeb1612f5fdb9df6bb17914f022191229de4072b2c4b98f33534a4b4bd70f6c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e333dd2380931aced0e9b05cc5122ed3256f39ce9faf065927d9429c5f7e4e47cf1f8213d81888ff51f1c75889bf52c59ecbc5f88af10c1b47227728b66c0e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0ab5eba7d0bc5f56541205000eacee80e1dfd87de5baf0ce0a03cb2239d7d57ccef607ffb3abbed818300764065d7b79706cebdde7ff84ca8502291e94e64b"} build_url:https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/Tz2ed14HQ4ehJhdTJ9h8Sg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52cbd909e1df4e7766dd398967f68c01b44c55bdb559a1b075a17b62c69fda7eb53e4de5e7b6a9f20bb61f377c00c4b1ca4e32768cea76255107ac4a077a3fe1", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccc0ff3373296f42c8209e5f2389b18df2459973049b768621b9993cf626a9414aeb1612f5fdb9df6bb17914f022191229de4072b2c4b98f33534a4b4bd70f6c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e333dd2380931aced0e9b05cc5122ed3256f39ce9faf065927d9429c5f7e4e47cf1f8213d81888ff51f1c75889bf52c59ecbc5f88af10c1b47227728b66c0e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0ab5eba7d0bc5f56541205000eacee80e1dfd87de5baf0ce0a03cb2239d7d57ccef607ffb3abbed818300764065d7b79706cebdde7ff84ca8502291e94e64b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 14:59:14.133778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:59:14.138135) ========= 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=920470bf432669ad7e3a5387000001ca-1505588599.740647-1346194066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 14:59:14.188103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 14:59:14.188431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 14:59:14.188760) ========= ========= Total master_lag: 0.41 =========