builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-077 starttime: 1506555820.15 results: success (0) revision: 69e3f89816455e567f1a20b694fd6afd549c82c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.150338) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.150800) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.151073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.170785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.171146) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 16:43:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-09-27 16:43:40 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.279832) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.280159) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:40.330216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 16:43:40.332598) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 69e3f89816455e567f1a20b694fd6afd549c82c7 --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 69e3f89816455e567f1a20b694fd6afd549c82c7 --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=20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 16:43:40,370 truncating revision to first 12 chars 2017-09-27 16:43:40,370 Setting DEBUG logging. 2017-09-27 16:43:40,370 attempt 1/10 2017-09-27 16:43:40,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/69e3f8981645?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 16:43:41,099 unpacking tar archive at: mozilla-central-69e3f8981645/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 16:43:41.396940) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:41.397318) ========= script_repo_revision: 69e3f89816455e567f1a20b694fd6afd549c82c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:41.401998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:41.402349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 16:43:41.422319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-27 16:43:41.422739) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:43:41 INFO - MultiFileLogger online at 20170927 16:43:41 in /builds/slave/test 16:43:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 16:43:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:43:41 INFO - {'append_to_log': False, 16:43:41 INFO - 'base_work_dir': '/builds/slave/test', 16:43:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:43:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:43:41 INFO - 'branch': 'Firefox-Non-PGO', 16:43:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:41 INFO - 'code_coverage': False, 16:43:41 INFO - 'config_files': ('talos/linux_config.py',), 16:43:41 INFO - 'default_actions': ('clobber', 16:43:41 INFO - 'read-buildbot-config', 16:43:41 INFO - 'download-and-extract', 16:43:41 INFO - 'populate-webroot', 16:43:41 INFO - 'create-virtualenv', 16:43:41 INFO - 'install', 16:43:41 INFO - 'setup-mitmproxy', 16:43:41 INFO - 'run-tests'), 16:43:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:41 INFO - 'disable_ccov_upload': False, 16:43:41 INFO - 'disable_stylo': False, 16:43:41 INFO - 'download_minidump_stackwalk': True, 16:43:41 INFO - 'download_symbols': 'ondemand', 16:43:41 INFO - 'enable_stylo': False, 16:43:41 INFO - 'enable_webrender': False, 16:43:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:43:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:41 INFO - 'gecko_profile': False, 16:43:41 INFO - 'gecko_profile_interval': 0, 16:43:41 INFO - 'installer_path': 'installer.exe', 16:43:41 INFO - 'log_level': 'info', 16:43:41 INFO - 'log_name': 'talos', 16:43:41 INFO - 'log_to_console': True, 16:43:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:43:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:43:41 INFO - 'opt_config_files': (), 16:43:41 INFO - 'pip_index': False, 16:43:41 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:43:41 INFO - 'system_bits': '32', 16:43:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:41 INFO - 'title': 'talos-linux64-ix-077', 16:43:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:41 INFO - 'use_talos_json': True, 16:43:41 INFO - 'verify': 'False', 16:43:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:43:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:41 INFO - 'work_dir': 'build'} 16:43:41 INFO - [mozharness: 2017-09-27 23:43:41.635667Z] Running clobber step. 16:43:41 INFO - Running pre-action listener: _resource_record_pre_action 16:43:41 INFO - Running main action method: clobber 16:43:41 INFO - rmtree: /builds/slave/test/build 16:43:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:43:42 INFO - Running post-action listener: _resource_record_post_action 16:43:42 INFO - [mozharness: 2017-09-27 23:43:42.623766Z] Finished clobber step (success) 16:43:42 INFO - [mozharness: 2017-09-27 23:43:42.623862Z] Running read-buildbot-config step. 16:43:42 INFO - Running pre-action listener: _resource_record_pre_action 16:43:42 INFO - Running main action method: read_buildbot_config 16:43:42 INFO - Using buildbot properties: 16:43:42 INFO - { 16:43:42 INFO - "project": "", 16:43:42 INFO - "product": "firefox", 16:43:42 INFO - "who": "archaeopteryx@coole-files.de", 16:43:42 INFO - "installer_path": "public/build/target.tar.bz2", 16:43:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:43:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:43:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 16:43:42 INFO - "stage_platform": "linux64", 16:43:42 INFO - "basedir": "/builds/slave/test", 16:43:42 INFO - "buildnumber": 73, 16:43:42 INFO - "platform": "ubuntu64_hw", 16:43:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:43:42 INFO - "slavebuilddir": "test", 16:43:42 INFO - "taskId": "KClaUgOxRoqQj0NWBPhaIw", 16:43:42 INFO - "branch": "mozilla-central", 16:43:42 INFO - "script_repo_revision": "production", 16:43:42 INFO - "revision": "69e3f89816455e567f1a20b694fd6afd549c82c7", 16:43:42 INFO - "slavename": "talos-linux64-ix-077", 16:43:42 INFO - "repo_path": "mozilla-central" 16:43:42 INFO - } 16:43:42 INFO - Finding installer, test and symbols from parent task. 16:43:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KClaUgOxRoqQj0NWBPhaIw'}, attempt #1 16:43:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KClaUgOxRoqQj0NWBPhaIw'}, attempt #1 16:43:43 INFO - Task dependencies: dp8k4SKiS8qEBmLBTOvhFQ 16:43:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ'}, attempt #1 16:43:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:43:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json 16:43:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip 16:43:43 INFO - Running post-action listener: _resource_record_post_action 16:43:43 INFO - [mozharness: 2017-09-27 23:43:43.974326Z] Finished read-buildbot-config step (success) 16:43:43 INFO - [mozharness: 2017-09-27 23:43:43.974548Z] Running download-and-extract step. 16:43:43 INFO - Running pre-action listener: _resource_record_pre_action 16:43:43 INFO - Running main action method: download_and_extract 16:43:43 INFO - mkdir: /builds/slave/test/build/tests 16:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:43 INFO - trying https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json 16:43:43 INFO - Downloading https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:43:44 INFO - Downloaded 989 bytes. 16:43:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:43:44 INFO - Using the following test package requirements: 16:43:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:43:44 INFO - u'common': [u'target.common.tests.zip'], 16:43:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:43:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:43:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:43:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:43:44 INFO - u'mozbase': [u'target.common.tests.zip'], 16:43:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:43:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:43:44 INFO - u'web-platform': [u'target.common.tests.zip', 16:43:44 INFO - u'target.web-platform.tests.tar.gz'], 16:43:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:43:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:43:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.common.tests.zip 16:43:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:43:44 INFO - Fetch https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.common.tests.zip into memory 16:43:45 INFO - Content-Length response header: 54945885 16:43:45 INFO - Bytes received: 54945885 16:43:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.talos.tests.zip 16:43:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:43:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.talos.tests.zip into memory 16:43:57 INFO - Content-Length response header: 14513779 16:43:57 INFO - Bytes received: 14513779 16:43: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')]} 16:43:57 INFO - trying https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:43:57 INFO - Downloading https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:43:58 INFO - Downloaded 61765788 bytes. 16:43:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:43:58 INFO - mkdir: /builds/slave/test/properties 16:43:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:58 INFO - Contents: 16:43:58 INFO - build_url:https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 16:43:58 INFO - Running post-action listener: _resource_record_post_action 16:43:58 INFO - Running post-action listener: find_tests_for_verification 16:43:58 INFO - Running post-action listener: set_extra_try_arguments 16:43:58 INFO - [mozharness: 2017-09-27 23:43:58.463444Z] Finished download-and-extract step (success) 16:43:58 INFO - [mozharness: 2017-09-27 23:43:58.463541Z] Running populate-webroot step. 16:43:58 INFO - Running pre-action listener: _resource_record_pre_action 16:43:58 INFO - Running main action method: populate_webroot 16:43:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['tresize', 16:43:58 INFO - 'tcanvasmark']}, 16:43:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['dromaeo_css', 16:43:58 INFO - 'kraken']}, 16:43:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'tests': ['damp', 'tps']}, 16:43:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['damp', 'tps']}, 16:43:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['dromaeo_dom']}, 16:43:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:43:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['basic_compositor_video', 16:43:58 INFO - 'glvideo']}, 16:43:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:43:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['ts_paint_webext', 16:43:58 INFO - 'tp5o_webext']}, 16:43:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:58 INFO - 'ts_paint', 16:43:58 INFO - 'tpaint', 16:43:58 INFO - 'sessionrestore', 16:43:58 INFO - 'sessionrestore_many_windows', 16:43:58 INFO - 'sessionrestore_no_auto_restore', 16:43:58 INFO - 'tabpaint']}, 16:43:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['a11yr', 16:43:58 INFO - 'ts_paint', 16:43:58 INFO - 'tpaint', 16:43:58 INFO - 'sessionrestore', 16:43:58 INFO - 'sessionrestore_many_windows', 16:43:58 INFO - 'sessionrestore_no_auto_restore', 16:43:58 INFO - 'tabpaint']}, 16:43:58 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:43:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:43:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['perf_reftest_singletons']}, 16:43:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['perf_reftest']}, 16:43:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:58 INFO - 'tsvgr_opacity', 16:43:58 INFO - 'tart', 16:43:58 INFO - 'tscrollx', 16:43:58 INFO - 'tsvg_static']}, 16:43:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['tsvgx', 16:43:58 INFO - 'tsvgr_opacity', 16:43:58 INFO - 'tart', 16:43:58 INFO - 'tscrollx', 16:43:58 INFO - 'tsvg_static']}, 16:43:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:43:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'talos_options': ['--disable-stylo'], 16:43:58 INFO - 'tests': ['tp5o']}, 16:43:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:43:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:43:58 INFO - 'talos_options': ['--mitmproxy', 16:43:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:43:58 INFO - '--firstNonBlankPaint'], 16:43:58 INFO - 'tests': ['tp6_google', 16:43:58 INFO - 'tp6_youtube', 16:43:58 INFO - 'tp6_amazon', 16:43:58 INFO - 'tp6_facebook']}, 16:43:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:43:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:43:58 INFO - 'talos_options': ['--disable-stylo', 16:43:58 INFO - '--mitmproxy', 16:43:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:43:58 INFO - '--firstNonBlankPaint'], 16:43:58 INFO - 'tests': ['tp6_google', 16:43:58 INFO - 'tp6_youtube', 16:43:58 INFO - 'tp6_amazon', 16:43:58 INFO - 'tp6_facebook']}, 16:43:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:43:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:43:58 INFO - 'talos_options': ['--stylo-threads=1', 16:43:58 INFO - '--mitmproxy', 16:43:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:43:58 INFO - '--firstNonBlankPaint'], 16:43:58 INFO - 'tests': ['tp6_google', 16:43:58 INFO - 'tp6_youtube', 16:43:58 INFO - 'tp6_amazon', 16:43:58 INFO - 'tp6_facebook']}, 16:43:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'talos_options': ['--xperf_path', 16:43:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:58 INFO - 'tests': ['tp5n']}, 16:43:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:43:58 INFO - 'talos_options': ['--disable-stylo', 16:43:58 INFO - '--xperf_path', 16:43:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:58 INFO - 'tests': ['tp5n']}}} 16:43:58 INFO - Running post-action listener: _resource_record_post_action 16:43:58 INFO - [mozharness: 2017-09-27 23:43:58.478886Z] Finished populate-webroot step (success) 16:43:58 INFO - [mozharness: 2017-09-27 23:43:58.478975Z] Running create-virtualenv step. 16:43:58 INFO - Running pre-action listener: _resource_record_pre_action 16:43:58 INFO - Running main action method: create_virtualenv 16:43:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:43:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:43:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:43:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:59 INFO - Installing pip...............done. 16:43:59 INFO - Return code: 0 16:43:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:43:59 INFO - Reading from file tmpfile_stdout 16:43:59 INFO - Output received: 16:43:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:43:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43: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')]} 16:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:43: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', 'pip>=1.5'] in /builds/slave/test/build 16:43: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 pip>=1.5 16:43:59 INFO - Using env: {'DISPLAY': ':0', 16:43:59 INFO - 'HOME': '/home/cltbld', 16:43:59 INFO - 'LANG': 'en_US.UTF-8', 16:43:59 INFO - 'LANGUAGE': 'en_US:en', 16:43:59 INFO - 'LOGNAME': 'cltbld', 16:43:59 INFO - 'MAIL': '/var/mail/cltbld', 16:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:59 INFO - 'MOZ_NO_REMOTE': '1', 16:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:59 INFO - 'NO_EM_RESTART': '1', 16:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:59 INFO - 'PWD': '/builds/slave/test', 16:43:59 INFO - 'SHELL': '/bin/bash', 16:43:59 INFO - 'SHLVL': '1', 16:43:59 INFO - 'TERM': 'linux', 16:43:59 INFO - 'TMOUT': '86400', 16:43:59 INFO - 'USER': 'cltbld', 16:43:59 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:59 INFO - '_': '/tools/buildbot/bin/python'} 16:44:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:44:00 INFO - Downloading/unpacking pip>=1.5 16:44:00 INFO - Running setup.py egg_info for package pip 16:44:00 INFO - warning: no files found matching 'pip/cacert.pem' 16:44:00 INFO - warning: no files found matching '*.html' under directory 'docs' 16:44:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:44:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:44:00 INFO - Installing collected packages: pip 16:44:00 INFO - Found existing installation: pip 1.1 16:44:01 INFO - Uninstalling pip: 16:44:01 INFO - Successfully uninstalled pip 16:44:01 INFO - Running setup.py install for pip 16:44:01 INFO - warning: no files found matching 'pip/cacert.pem' 16:44:01 INFO - warning: no files found matching '*.html' under directory 'docs' 16:44:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:44:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:44:01 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:44:01 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:44:01 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:44:01 INFO - Successfully installed pip 16:44:01 INFO - Cleaning up... 16:44:01 INFO - Return code: 0 16:44:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44: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')]} 16:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:44:01 INFO - Using env: {'DISPLAY': ':0', 16:44:01 INFO - 'HOME': '/home/cltbld', 16:44:01 INFO - 'LANG': 'en_US.UTF-8', 16:44:01 INFO - 'LANGUAGE': 'en_US:en', 16:44:01 INFO - 'LOGNAME': 'cltbld', 16:44:01 INFO - 'MAIL': '/var/mail/cltbld', 16:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:01 INFO - 'MOZ_NO_REMOTE': '1', 16:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:01 INFO - 'NO_EM_RESTART': '1', 16:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:01 INFO - 'PWD': '/builds/slave/test', 16:44:01 INFO - 'SHELL': '/bin/bash', 16:44:01 INFO - 'SHLVL': '1', 16:44:01 INFO - 'TERM': 'linux', 16:44:01 INFO - 'TMOUT': '86400', 16:44:01 INFO - 'USER': 'cltbld', 16:44:01 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:01 INFO - '_': '/tools/buildbot/bin/python'} 16:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:01 INFO - Downloading/unpacking psutil>=3.1.1 16:44: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 16:44: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 16:44: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 16:44: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 16:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:02 INFO - Installing collected packages: psutil 16:44:02 INFO - Running setup.py install for psutil 16:44:02 INFO - building 'psutil._psutil_linux' extension 16:44:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:44:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:44:02 INFO - building 'psutil._psutil_posix' extension 16:44:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:44:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:03 INFO - Successfully installed psutil 16:44:03 INFO - Cleaning up... 16:44:03 INFO - Return code: 0 16:44:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44: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')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:44: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 16:44: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 16:44: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 16:44: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 16:44:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:04 INFO - Installing collected packages: mozsystemmonitor 16:44:04 INFO - Running setup.py install for mozsystemmonitor 16:44:04 INFO - Successfully installed mozsystemmonitor 16:44:04 INFO - Cleaning up... 16:44:04 INFO - Return code: 0 16:44:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:04 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:04 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 16:44:04 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 16:44:04 INFO - Using env: {'DISPLAY': ':0', 16:44:04 INFO - 'HOME': '/home/cltbld', 16:44:04 INFO - 'LANG': 'en_US.UTF-8', 16:44:04 INFO - 'LANGUAGE': 'en_US:en', 16:44:04 INFO - 'LOGNAME': 'cltbld', 16:44:04 INFO - 'MAIL': '/var/mail/cltbld', 16:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:04 INFO - 'MOZ_NO_REMOTE': '1', 16:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:04 INFO - 'NO_EM_RESTART': '1', 16:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:04 INFO - 'PWD': '/builds/slave/test', 16:44:04 INFO - 'SHELL': '/bin/bash', 16:44:04 INFO - 'SHLVL': '1', 16:44:04 INFO - 'TERM': 'linux', 16:44:04 INFO - 'TMOUT': '86400', 16:44:04 INFO - 'USER': 'cltbld', 16:44:04 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:04 INFO - '_': '/tools/buildbot/bin/python'} 16:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:05 INFO - Downloading/unpacking jsonschema==2.5.1 16:44:05 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 16:44:05 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 16:44:05 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 16:44:05 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 16:44:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:44: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 16:44: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 16:44: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 16:44: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 16:44:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:06 INFO - warning: no files found matching '*.txt' 16:44:06 INFO - no previously-included directories found matching 'build' 16:44:06 INFO - no previously-included directories found matching 'dist' 16:44:06 INFO - no previously-included directories found matching '.git*' 16:44:06 INFO - Installing collected packages: jsonschema, functools32 16:44:06 INFO - Running setup.py install for functools32 16:44:06 INFO - warning: no files found matching '*.txt' 16:44:06 INFO - no previously-included directories found matching 'build' 16:44:06 INFO - no previously-included directories found matching 'dist' 16:44:06 INFO - no previously-included directories found matching '.git*' 16:44:06 INFO - Successfully installed jsonschema functools32 16:44:06 INFO - Cleaning up... 16:44:06 INFO - Return code: 0 16:44:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44: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')]} 16:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:44:06 INFO - Using env: {'DISPLAY': ':0', 16:44:06 INFO - 'HOME': '/home/cltbld', 16:44:06 INFO - 'LANG': 'en_US.UTF-8', 16:44:06 INFO - 'LANGUAGE': 'en_US:en', 16:44:06 INFO - 'LOGNAME': 'cltbld', 16:44:06 INFO - 'MAIL': '/var/mail/cltbld', 16:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:06 INFO - 'MOZ_NO_REMOTE': '1', 16:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:06 INFO - 'NO_EM_RESTART': '1', 16:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:06 INFO - 'PWD': '/builds/slave/test', 16:44:06 INFO - 'SHELL': '/bin/bash', 16:44:06 INFO - 'SHLVL': '1', 16:44:06 INFO - 'TERM': 'linux', 16:44:06 INFO - 'TMOUT': '86400', 16:44:06 INFO - 'USER': 'cltbld', 16:44:06 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:06 INFO - '_': '/tools/buildbot/bin/python'} 16:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:44:06 INFO - Cleaning up... 16:44:06 INFO - Return code: 0 16:44:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44: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')]} 16:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:44:06 INFO - Using env: {'DISPLAY': ':0', 16:44:06 INFO - 'HOME': '/home/cltbld', 16:44:06 INFO - 'LANG': 'en_US.UTF-8', 16:44:06 INFO - 'LANGUAGE': 'en_US:en', 16:44:06 INFO - 'LOGNAME': 'cltbld', 16:44:06 INFO - 'MAIL': '/var/mail/cltbld', 16:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:06 INFO - 'MOZ_NO_REMOTE': '1', 16:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:06 INFO - 'NO_EM_RESTART': '1', 16:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:06 INFO - 'PWD': '/builds/slave/test', 16:44:06 INFO - 'SHELL': '/bin/bash', 16:44:06 INFO - 'SHLVL': '1', 16:44:06 INFO - 'TERM': 'linux', 16:44:06 INFO - 'TMOUT': '86400', 16:44:06 INFO - 'USER': 'cltbld', 16:44:06 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:06 INFO - '_': '/tools/buildbot/bin/python'} 16:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:08 INFO - Downloading docopt-0.6.1.tar.gz 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:08 INFO - Running setup.py install for blobuploader 16:44:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:08 INFO - Running setup.py install for requests 16:44:09 INFO - Running setup.py install for docopt 16:44:09 INFO - Successfully installed blobuploader requests docopt 16:44:09 INFO - Cleaning up... 16:44:09 INFO - Return code: 0 16:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:09 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')]} 16:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:09 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')]} 16:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:09 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:09 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 16:44:09 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 16:44:09 INFO - Using env: {'DISPLAY': ':0', 16:44:09 INFO - 'HOME': '/home/cltbld', 16:44:09 INFO - 'LANG': 'en_US.UTF-8', 16:44:09 INFO - 'LANGUAGE': 'en_US:en', 16:44:09 INFO - 'LOGNAME': 'cltbld', 16:44:09 INFO - 'MAIL': '/var/mail/cltbld', 16:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:09 INFO - 'MOZ_NO_REMOTE': '1', 16:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:09 INFO - 'NO_EM_RESTART': '1', 16:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:09 INFO - 'PWD': '/builds/slave/test', 16:44:09 INFO - 'SHELL': '/bin/bash', 16:44:09 INFO - 'SHLVL': '1', 16:44:09 INFO - 'TERM': 'linux', 16:44:09 INFO - 'TMOUT': '86400', 16:44:09 INFO - 'USER': 'cltbld', 16:44:09 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:09 INFO - '_': '/tools/buildbot/bin/python'} 16:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:09 INFO - Running setup.py (path:/tmp/pip-wxUVtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:09 INFO - Running setup.py (path:/tmp/pip-2LKM3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:09 INFO - Running setup.py (path:/tmp/pip-eQjURr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:09 INFO - Running setup.py (path:/tmp/pip-YX1Uae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:09 INFO - Running setup.py (path:/tmp/pip-iBY3Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:09 INFO - Running setup.py (path:/tmp/pip-sKx1J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:09 INFO - Running setup.py (path:/tmp/pip-Hsb6bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:10 INFO - Running setup.py (path:/tmp/pip-igLG5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:10 INFO - Running setup.py (path:/tmp/pip-06GgQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:10 INFO - Running setup.py (path:/tmp/pip-CzCbjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:10 INFO - Running setup.py (path:/tmp/pip-dv4kGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:10 INFO - Running setup.py (path:/tmp/pip-Zo2Mc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:10 INFO - Running setup.py (path:/tmp/pip-0uPZDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:10 INFO - Running setup.py (path:/tmp/pip-AkzxKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:10 INFO - Running setup.py (path:/tmp/pip-PonfOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:10 INFO - Running setup.py (path:/tmp/pip-JgHp6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:10 INFO - Running setup.py (path:/tmp/pip-jTOSAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:10 INFO - Running setup.py install for manifestparser 16:44:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:10 INFO - Running setup.py install for mozcrash 16:44:10 INFO - Running setup.py install for mozdebug 16:44:11 INFO - Running setup.py install for mozdevice 16:44:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozfile 16:44:11 INFO - Running setup.py install for mozhttpd 16:44:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozinfo 16:44:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozInstall 16:44:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozleak 16:44:11 INFO - Running setup.py install for mozlog 16:44:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for moznetwork 16:44:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozprocess 16:44:11 INFO - Running setup.py install for mozprofile 16:44:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Running setup.py install for mozrunner 16:44:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Running setup.py install for mozscreenshot 16:44:12 INFO - Running setup.py install for moztest 16:44:12 INFO - Running setup.py install for mozversion 16:44:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:12 INFO - Cleaning up... 16:44:12 INFO - Return code: 0 16:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:12 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:12 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 16:44:12 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 16:44:12 INFO - Using env: {'DISPLAY': ':0', 16:44:12 INFO - 'HOME': '/home/cltbld', 16:44:12 INFO - 'LANG': 'en_US.UTF-8', 16:44:12 INFO - 'LANGUAGE': 'en_US:en', 16:44:12 INFO - 'LOGNAME': 'cltbld', 16:44:12 INFO - 'MAIL': '/var/mail/cltbld', 16:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:12 INFO - 'MOZ_NO_REMOTE': '1', 16:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:12 INFO - 'NO_EM_RESTART': '1', 16:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:12 INFO - 'PWD': '/builds/slave/test', 16:44:12 INFO - 'SHELL': '/bin/bash', 16:44:12 INFO - 'SHLVL': '1', 16:44:12 INFO - 'TERM': 'linux', 16:44:12 INFO - 'TMOUT': '86400', 16:44:12 INFO - 'USER': 'cltbld', 16:44:12 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:12 INFO - '_': '/tools/buildbot/bin/python'} 16:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:12 INFO - Running setup.py (path:/tmp/pip-MyyZn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:12 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)) 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:12 INFO - Running setup.py (path:/tmp/pip-u0dXSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:12 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)) 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:12 INFO - Running setup.py (path:/tmp/pip-ClxeiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:12 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)) 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:12 INFO - Running setup.py (path:/tmp/pip-s54BzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:12 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)) 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:13 INFO - Running setup.py (path:/tmp/pip-n9D0gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:13 INFO - Running setup.py (path:/tmp/pip-YX9_Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:13 INFO - Running setup.py (path:/tmp/pip-2lmuzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:13 INFO - Running setup.py (path:/tmp/pip-na26ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:13 INFO - Running setup.py (path:/tmp/pip-D9Gsk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:13 INFO - Running setup.py (path:/tmp/pip-HwnNrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:13 INFO - Running setup.py (path:/tmp/pip-mb6q72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:13 INFO - Running setup.py (path:/tmp/pip-BbOreO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:13 INFO - Running setup.py (path:/tmp/pip-n4kYKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:13 INFO - Running setup.py (path:/tmp/pip-qb4jGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:13 INFO - Running setup.py (path:/tmp/pip-GY2BBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:13 INFO - Running setup.py (path:/tmp/pip-1BlJkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:13 INFO - Running setup.py (path:/tmp/pip-WNu7zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44: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 16:44: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 16:44: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 16:44: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 16:44:15 INFO - Downloading blessings-1.6.tar.gz 16:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:15 INFO - Installing collected packages: blessings 16:44:15 INFO - Running setup.py install for blessings 16:44:15 INFO - Successfully installed blessings 16:44:15 INFO - Cleaning up... 16:44:15 INFO - Return code: 0 16:44:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:15 INFO - Reading from file tmpfile_stdout 16:44:15 INFO - Current package versions: 16:44:15 INFO - argparse == 1.2.1 16:44:15 INFO - blessings == 1.6 16:44:15 INFO - blobuploader == 1.2.4 16:44:15 INFO - docopt == 0.6.1 16:44:15 INFO - functools32 == 3.2.3-2 16:44:15 INFO - jsonschema == 2.5.1 16:44:15 INFO - manifestparser == 1.1 16:44:15 INFO - mozInstall == 1.13 16:44:15 INFO - mozcrash == 1.0 16:44:15 INFO - mozdebug == 0.1 16:44:15 INFO - mozdevice == 0.51 16:44:15 INFO - mozfile == 1.2 16:44:15 INFO - mozhttpd == 0.7 16:44:15 INFO - mozinfo == 0.10 16:44:15 INFO - mozleak == 0.1 16:44:15 INFO - mozlog == 3.5 16:44:15 INFO - moznetwork == 0.27 16:44:15 INFO - mozprocess == 0.25 16:44:15 INFO - mozprofile == 0.28 16:44:15 INFO - mozrunner == 6.13 16:44:15 INFO - mozscreenshot == 0.1 16:44:15 INFO - mozsystemmonitor == 0.3 16:44:15 INFO - moztest == 0.8 16:44:15 INFO - mozversion == 1.4 16:44:15 INFO - psutil == 3.1.1 16:44:15 INFO - requests == 1.2.3 16:44:15 INFO - wsgiref == 0.1.2 16:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44: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')]} 16:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:15 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:15 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 16:44:15 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 16:44:15 INFO - Using env: {'DISPLAY': ':0', 16:44:15 INFO - 'HOME': '/home/cltbld', 16:44:15 INFO - 'LANG': 'en_US.UTF-8', 16:44:15 INFO - 'LANGUAGE': 'en_US:en', 16:44:15 INFO - 'LOGNAME': 'cltbld', 16:44:15 INFO - 'MAIL': '/var/mail/cltbld', 16:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:15 INFO - 'MOZ_NO_REMOTE': '1', 16:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:15 INFO - 'NO_EM_RESTART': '1', 16:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:15 INFO - 'PWD': '/builds/slave/test', 16:44:15 INFO - 'SHELL': '/bin/bash', 16:44:15 INFO - 'SHLVL': '1', 16:44:15 INFO - 'TERM': 'linux', 16:44:15 INFO - 'TMOUT': '86400', 16:44:15 INFO - 'USER': 'cltbld', 16:44:15 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:15 INFO - '_': '/tools/buildbot/bin/python'} 16:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 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)) 16:44:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:44:16 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)) 16:44:16 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)) 16:44:16 INFO - Installing collected packages: simplejson 16:44:16 INFO - Running setup.py install for simplejson 16:44:16 INFO - building 'simplejson._speedups' extension 16:44:16 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 16:44:17 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 16:44:17 INFO - Successfully installed simplejson 16:44:17 INFO - Cleaning up... 16:44:17 INFO - Return code: 0 16:44:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:17 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 0xe801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ed9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', '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 16:44:17 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 16:44:17 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 16:44:17 INFO - Using env: {'DISPLAY': ':0', 16:44:17 INFO - 'HOME': '/home/cltbld', 16:44:17 INFO - 'LANG': 'en_US.UTF-8', 16:44:17 INFO - 'LANGUAGE': 'en_US:en', 16:44:17 INFO - 'LOGNAME': 'cltbld', 16:44:17 INFO - 'MAIL': '/var/mail/cltbld', 16:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:17 INFO - 'MOZ_NO_REMOTE': '1', 16:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:17 INFO - 'NO_EM_RESTART': '1', 16:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:17 INFO - 'PWD': '/builds/slave/test', 16:44:17 INFO - 'SHELL': '/bin/bash', 16:44:17 INFO - 'SHLVL': '1', 16:44:17 INFO - 'TERM': 'linux', 16:44:17 INFO - 'TMOUT': '86400', 16:44:17 INFO - 'USER': 'cltbld', 16:44:17 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:17 INFO - '_': '/tools/buildbot/bin/python'} 16:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:18 INFO - Cleaning up... 16:44:18 INFO - Return code: 0 16:44:18 INFO - Running post-action listener: _resource_record_post_action 16:44:18 INFO - Running post-action listener: _start_resource_monitoring 16:44:18 INFO - Starting resource monitoring. 16:44:18 INFO - [mozharness: 2017-09-27 23:44:18.205779Z] Finished create-virtualenv step (success) 16:44:18 INFO - [mozharness: 2017-09-27 23:44:18.206253Z] Running install step. 16:44:18 INFO - Running pre-action listener: _resource_record_pre_action 16:44:18 INFO - Running main action method: install 16:44:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:18 INFO - Reading from file tmpfile_stdout 16:44:18 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:18 INFO - Reading from file tmpfile_stdout 16:44:18 INFO - Output received: 16:44:18 INFO - Usage: mozinstall [options] installer 16:44:18 INFO - Options: 16:44:18 INFO - -h, --help show this help message and exit 16:44:18 INFO - -d DEST, --destination=DEST 16:44:18 INFO - Directory to install application into. [default: 16:44:18 INFO - "/builds/slave/test"] 16:44:18 INFO - --app=APP Application being installed. [default: firefox] 16:44:18 INFO - mkdir: /builds/slave/test/build/application 16:44:18 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'] 16:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:44:36 INFO - Reading from file tmpfile_stdout 16:44:36 INFO - Output received: 16:44:36 INFO - /builds/slave/test/build/application/firefox/firefox 16:44:36 INFO - Running post-action listener: _resource_record_post_action 16:44:36 INFO - [mozharness: 2017-09-27 23:44:36.376658Z] Finished install step (success) 16:44:36 INFO - [mozharness: 2017-09-27 23:44:36.376912Z] Running setup-mitmproxy step. 16:44:36 INFO - Running pre-action listener: _resource_record_pre_action 16:44:36 INFO - Running main action method: setup_mitmproxy 16:44:36 INFO - Skipping: mitmproxy is not required 16:44:36 INFO - Running post-action listener: _resource_record_post_action 16:44:36 INFO - [mozharness: 2017-09-27 23:44:36.378041Z] Finished setup-mitmproxy step (success) 16:44:36 INFO - [mozharness: 2017-09-27 23:44:36.378276Z] Running run-tests step. 16:44:36 INFO - Running pre-action listener: _resource_record_pre_action 16:44:36 INFO - Running pre-action listener: _set_gcov_prefix 16:44:36 INFO - Running main action method: run_tests 16:44:36 WARNING - Try message not found. 16:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:36 INFO - Python 2.7.3 16:44:36 INFO - Return code: 0 16:44:36 INFO - grabbing minidump binary from tooltool 16:44:36 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')]} 16:44:36 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 0x11ead60>, '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 0x11eba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ebef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:36 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 16:44:36 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 16:44:36 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 16:44:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:36 INFO - Return code: 0 16:44:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:44:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:36 INFO - ENV: RUST_BACKTRACE is now full 16:44:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:44:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:36 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:44:36 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:44:36 INFO - Using env: {'DISPLAY': ':0', 16:44:36 INFO - 'HOME': '/home/cltbld', 16:44:36 INFO - 'LANG': 'en_US.UTF-8', 16:44:36 INFO - 'LANGUAGE': 'en_US:en', 16:44:36 INFO - 'LOGNAME': 'cltbld', 16:44:36 INFO - 'MAIL': '/var/mail/cltbld', 16:44:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:36 INFO - 'MOZ_NO_REMOTE': '1', 16:44:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:36 INFO - 'NO_EM_RESTART': '1', 16:44:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:36 INFO - 'PWD': '/builds/slave/test', 16:44:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:36 INFO - 'RUST_BACKTRACE': 'full', 16:44:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:44:36 INFO - 'SHELL': '/bin/bash', 16:44:36 INFO - 'SHLVL': '1', 16:44:36 INFO - 'TERM': 'linux', 16:44:36 INFO - 'TMOUT': '86400', 16:44:36 INFO - 'USER': 'cltbld', 16:44:36 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:36 INFO - '_': '/tools/buildbot/bin/python'} 16:44:36 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:44:36 INFO - mozversion application_buildid: 20170927215532 16:44:36 INFO - mozversion application_changeset: 69e3f89816455e567f1a20b694fd6afd549c82c7 16:44:36 INFO - mozversion application_display_name: Nightly 16:44:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:36 INFO - mozversion application_name: Firefox 16:44:36 INFO - mozversion application_remotingname: firefox 16:44:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:44:36 INFO - mozversion application_vendor: Mozilla 16:44:36 INFO - mozversion application_version: 58.0a1 16:44:36 INFO - mozversion platform_buildid: 20170927215532 16:44:36 INFO - mozversion platform_changeset: 69e3f89816455e567f1a20b694fd6afd549c82c7 16:44:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:44:36 INFO - mozversion platform_version: 58.0a1 16:44:36 INFO - using testdate: 1506555876 16:44:36 INFO - actual date: 1506555876 16:44:36 INFO - starting webserver on 'localhost:52656' 16:44:36 INFO - SUITE-START | Running 2 tests 16:44:36 INFO - TEST-START | dromaeo_css 16:44:36 INFO - Initialising browser for dromaeo_css test... 16:44:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52656/getInfo.html -profile /tmp/tmp25Q3Ly/profile 16:44:36 INFO - TEST-INFO | started process 16807 (/builds/slave/test/build/application/firefox/firefox http://localhost:52656/getInfo.html) 16:44:42 INFO - TEST-INFO | 16807: exit 0 16:44:42 INFO - Browser initialized. 16:44:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:42 INFO - Using env: {'DISPLAY': ':0', 16:44:42 INFO - 'HOME': '/home/cltbld', 16:44:42 INFO - 'JSGC_DISABLE_POISONING': '1', 16:44:42 INFO - 'LANG': 'en_US.UTF-8', 16:44:42 INFO - 'LANGUAGE': 'en_US:en', 16:44:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:44:42 INFO - 'LOGNAME': 'cltbld', 16:44:42 INFO - 'MAIL': '/var/mail/cltbld', 16:44:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:42 INFO - 'MOZ_CRASHREPORTER': '1', 16:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:44:42 INFO - 'MOZ_NO_REMOTE': '1', 16:44:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:42 INFO - 'NO_EM_RESTART': '1', 16:44:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:42 INFO - 'PWD': '/builds/slave/test', 16:44:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:42 INFO - 'RUST_BACKTRACE': 'full', 16:44:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:44:42 INFO - 'SHELL': '/bin/bash', 16:44:42 INFO - 'SHLVL': '1', 16:44:42 INFO - 'STYLO_FORCE_DISABLED': '1', 16:44:42 INFO - 'TERM': 'linux', 16:44:42 INFO - 'TMOUT': '86400', 16:44:42 INFO - 'USER': 'cltbld', 16:44:42 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 16:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:42 INFO - '_': '/tools/buildbot/bin/python'} 16:44:42 INFO - TEST-INFO | started process 17040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25Q3Ly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:43 INFO - PID 17040 | 16:44:43 INFO - PID 17040 | (/builds/slave/test/build/application/firefox/firefox:17088): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:44:43 INFO - PID 17040 | 16:44:53 INFO - PID 17040 | RSS: Main: 151506944 16:44:53 INFO - PID 17040 | 16:47:51 INFO - PID 17040 | Cycle 1(1): loaded http://localhost:52656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52656/tests/dromaeo/cssquery-ext.html) 16:47:53 INFO - PID 17040 | RSS: Main: 151547904 16:47:53 INFO - PID 17040 | 16:50:55 INFO - PID 17040 | Cycle 1(1): loaded http://localhost:52656/tests/dromaeo/cssquery-ext.html (next: http://localhost:52656/tests/dromaeo/cssquery-jquery.html) 16:50:55 INFO - PID 17040 | RSS: Main: 150757376 16:50:55 INFO - PID 17040 | 16:53:57 INFO - PID 17040 | Cycle 1(1): loaded http://localhost:52656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52656/tests/dromaeo/cssquery-mootools.html) 16:53:57 INFO - PID 17040 | RSS: Main: 151670784 16:53:57 INFO - PID 17040 | 16:56:59 INFO - PID 17040 | Cycle 1(1): loaded http://localhost:52656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52656/tests/dromaeo/cssquery-prototype.html) 16:57:00 INFO - PID 17040 | RSS: Main: 151588864 16:57:00 INFO - PID 17040 | 17:00:03 INFO - PID 17040 | Cycle 1(1): loaded http://localhost:52656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52656/tests/dromaeo/cssquery-yui.html) 17:00:04 INFO - PID 17040 | RSS: Main: 154501120 17:00:04 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | Cycle 1(1): loaded http://localhost:52656/tests/dromaeo/cssquery-yui.html (next: http://localhost:52656/tests/dromaeo/cssquery-dojo.html) 17:03:05 INFO - PID 17040 | RSS: Main: 155398144 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | __start_tp_report 17:03:05 INFO - PID 17040 | _x_x_mozilla_page_load 17:03:05 INFO - PID 17040 | _x_x_mozilla_page_load_details 17:03:05 INFO - PID 17040 | |i|pagename|runs| 17:03:05 INFO - PID 17040 | |0;dojo.html;3262.054004338741;3291.2923721399893;3294.7199488043507;3308.652591477893;3308.718758905493;6271.968640156792;6362.04569314603;6494.253160886499;6496.285408605049;6499.057636642684;6313.053042043684;6358.650274234915;6433.678316084189;6525.510586706004;6553.442957348631;5843;5939.970300148493;5945.970270148643;5947.464728174464;5983.1623572699855;5762.510186634141;5874.471297583216;5947.375525569818;6009.699515024253;6018.8495287617725;5881.500072493843;5916.497097746696;5930.288365396159;5934.970325148347;6030.155778191035;5747.1666608341975;5801.187833703285;5830.4461076197695;5855.941440585582;5862.765489380419;5828.854278643068;5837.854053648651;5844.094165404369;5874.1776151338845;5894.145348924382;6348.428641422248;6383;6390.233172019341;6428.646424446653;6524.314946930599;6677.833054173636;6785.423239024689;6883.690233939485;6939.444844412435;6965.442764578822;6840.384365407137;6847.17833859935;6858.417034552069;6860.176778786527;6865.313468653145;6247.656378899204;6330.145430366888;6333.398327158912;6339.492840572743;6340.239171299428;7005.334493223238;7011.404030657349;7029.261927497641;7123.857522849514;7171.677274522659;6716.899246511306;6797.5581587196675;6803.727850886008;6817.11377520929;6828.863422731617;6884.139482564679;6892.965535172292;6943.9652801735665;6991.196012458632;7025.367716905401;6664.333566643297;6744.359285867835;6783.59298442095;6793.932060679429;6794.626295553792;6941.167059952737;6943.826404339932;6945.305469453116;6963.825904352431;6977.79066628002;5006.324146240284;5065.088284108896;5072.340595722532;5073.619478539124;5074.035933172685;4374.650027997816;4388.626966707801;4420.823167073281;4421.624161946271;4429.247028005247;5779.566532509994;5815.854603634943;5832.533397328203;5842.415758424124;5905.6161349513;6787.830304242433;6812.897806532906;6913.792586222421;6915.4121899638085;6920.204176519765;5840.620359676607;5925.05199168131;5930.318013428425;5959.880802383928;5973.820785376446;5834.066549352084;5881.088431293157;5919.378465261172;5926.822195334147;5967.880642387215;6614.801555953329;6637;6668.399844014062;6727.62998035103;6736.730530778812;6704.83237919056;6833.897491537531;6855.451563874978;6957.1651401832105;6968.477364197604;6609.339066093352;6686.197656281277;6695.631740254333;6717.764878229238;6760;6799.93200067993;6828.146481689789;6881.10545629065;6903.0680858083515;6903.102596662402;6923.134608173978;6944.270851560514;7024.5434046786795;7028.156621205488;7031.824204394931;6519.706613202512;6633.237177724431;6646.069550263063;6746.831329216809;6755.527113102232;6615.56998795096;6704.564203326768;6714.261431242657;6720.563163394364;6744.898826517508;6587;6685.431738302299;6686.364795344434;6699.799006029827;6706.094677218513;6747.156605424322;6758.662066896733;6830.282820303796;6830.795076147723;6847.828804279933;6362.9681851592295;6446.0975463434215;6448.64532450701;6483.675816209076;6589.769358072636 17:03:05 INFO - PID 17040 | |1;ext.html;851.723189963262;872.8297981893529;874.0865795243969;875.1161327059664;875.7679215008023;40695.59304406955;41449.17101657965;41606;41608.37587436191;41709.58290417099;37695.434568481425;37953;38024;38036.61963380365;38052.23895522095;6885.345892140252;7323.780286591411;7326.963365183166;7335.559866408006;7336.119665640131;7195.89206161908;7243.456740744439;7267.672954717024;7303.926960730378;7310.634468276591;7236.240194779525;7266.890996635055;7957.5225486471;8157.347412207009;8164.959175204116;8072.596370181497;8141.79645508867;8142.837143257161;8148.388870834711;8152.592370381517;7905.486143400661;7940.404469664741;8003.319717823992;8024.799380015488;8033.076196237449;38430.61569384326;38697.226055478735;38780.80609596962;38786.22427551433;38984.22031559353;3543.3976224041976;3595.3708101082207;3600.6399360064047;3604.098975256186;3604.9279014419567;32053.839730801195;32106;32275.19312017195;32382;32423.51364729531;5050.292958985745;5260.210968354778;5268.841934741964;5275.235090911796;5299.49654782795;189764;190434;190615;190990;191395;42570.78714606469;43171;48787;49220.507794922305;49681;51785.22322165171;51786.48213517892;51816.48183518116;51838.22242666363;51864;15283.923580382027;15380.15409152485;15446.995945263521;15464.381424742884;15478.922605387126;12359.011279097651;12361.567345142877;12413.627591172279;12547.874521254671;12603;14446.494372696905;14474.203918784568;14527.346269417902;14562.053466524641;14587.927060364631;5746.655610282477;5798.478136967693;5814.941850581525;5999.160117583542;6034.215551978303;1025.5795123999123;1033.225081189108;1040.8386700061503;1048.3447845096814;1049.4385503755454;23005.309840704806;23061.654075188886;23231.76768232296;23268.767312327;23349.182778602666;1113.9665810025713;1136.6192325571026;1137.4199158429096;1137.5620386151227;1146.587228597704;12147.210431322113;12327.568535101229;12361.381930903419;12366.876331236752;12372.62882113538;221962;222334;223439;223441;224264;52211.73894130581;52359.73820130951;52398.21402678963;52496.73751631294;52605.7369713149;1438.359929831236;1464.4947493114857;1483.903546269489;1485.725140848968;1490.7316682996948;22278;22372.216972405888;22522.5495490086;22585.661215081458;22709.205177818698;36719.26561468809;36812.44781328336;36879.63120368762;36944.261114777015;36951.630483695895;194951;195326;196021;196596;196869;33611.83194084014;35654.821725891205;36388.636113638524;36570.26859462849;36574.634253657125;43681;45027.32459013052;45123.774381127885;45257.32114018226;45450.31824522701;32982.835085824416;33077.66922330746;33276.50085248772;33589;33718;33416.66583334136;33447.66552334543;33476.33047339088;33530.329393411506;33694.49458258177;37226;37285.81357093197;37480.2503949914;37520.061998450255;37693.246135077694;31848.36303273968;32463.513047303837;32610;32670.83664581662;32686.673133269313;23892.88053559721;24426.63360049565;24515.387115321548;24820.503589928463;25113 17:03:05 INFO - PID 17040 | |2;jquery.html;578.9421057894208;588.6203398807767;596.3053043204667;597.9701014949252;600.8918394688956;22533.436664083405;23237.535249295004;23374.649380259267;23394.94722737479;23430.531389372245;23144.768552314472;24644.137455189073;24817.627735583934;24980.375490612743;25064.373390665198;6632.436242919345;6795.286494918037;6813.420859226947;6815.352541508573;6828.897566536506;6366.93633063668;6620.536562440631;6680.164979377578;6783.253842077367;6796.660166991655;6586.209654841426;6591.044298576728;6595.736170553196;6597.472202223835;6600.174978127734;6567.638779867106;6599;6603.14159159311;6606.603603783764;6607.2071351438135;6093.390660933916;6936.237013928464;7233.638318084075;7264.309890560441;7286.271372862724;29919.102426927227;30330.393392132253;30561;30624.2343941401;30637.38725225483;2065.297798748418;2072.3886453496257;2085.1450905128822;2097.4336929029078;2099.88450635215;19948.301809436743;20619.381418557467;20911.268105616382;20959.476013099644;21127.47181320464;2546.2870396289068;2564.8332858364147;2584;2618.2145356393007;2655.389260470083;128266;132977;140334;144508;151123.24438377848;19488.805111948983;20777.896110519352;21355.893220534108;22122.88938555329;22445.551088978456;42637.786811065744;42712.57287427148;42732;42889;42903;10719.088877445349;10784.191185661106;10803.945980270048;10937.398443085707;10970.232083754061;8807.823843523222;8873.511956842307;8923.866142007875;8941.776455588531;8947.865782013276;10881.347119172875;11350.588329184926;11573.710657233636;11599.594014209462;11853.46659400329;4074.8573799917453;4092.8567500137947;4253.065914029572;4303.526612072669;4438.977805111019;941.8351788436996;952.8523078922778;964.0841200859212;972.8103019911049;976.7167521418709;19217.231310747415;19253.90373048126;19578.804211957697;19629.901850490656;19712.802871971384;1015.1016350529686;1017.1100287248657;1020.2501161646184;1025.4718819807806;1028.7582418131733;10396.16830653546;10488.26582139243;10570.788584228272;10861.891381086247;10861.945690271497;486929;494456;507195;518031;533714;105612.47193763981;106939;107668;107974;113916.43041784738;1144.0618692672097;1155.3472288157163;1181.373871847922;1184.407796101949;1185.9822102668468;16602.418915337905;17181.31274748996;17299.30802767875;17467.56331091733;17554.21006054705;53974.460255396945;54526;54976.72511637416;55028;56700;69504;69749.65125174342;70298;70384.64807675929;70466.29533704597;19282;19401.611967760284;19572.8042719571;19739.802601973795;19778.208871645547;22180.88909555442;22257.44356391103;22437.32688019362;22557.774422256225;22569.774302256767;17733.911330443265;17823.643527129643;17877.642447151244;17988.460346189637;17989.10054497296;15162.848371516144;15754.369825206863;15818.68362632764;15938.920305398398;16198.757018644965;18552.44342669722;18562.071896404857;18825.529361766065;18836.905815471382;19057.523561910508;18929.148188331284;19273.710894336316;19358.70961935544;19431.61136777285;19507;17722.73415898737;17914.91042544831;17943.910280448516;18047.81952180514;18049.548761281072 17:03:05 INFO - PID 17040 | |3;mootools.html;1314.2705798281952;1344.8991325650572;1371.9451221951122;1372.8764411202992;1378.9310534473275;15395.692086158284;16066.437674681389;16079.678406431864;16084;16086.83913160868;15615.063096214235;15689.29398177082;15731.84268157318;15752;15767.448139315125;2733.72662733727;2838.7303206195484;2840.247334456371;2841.076650088719;2843.829370237782;2687.4759421912736;2711.2950632835505;2770.556710926252;2784.49879021776;2785;2729.931751706203;2756.986215068922;2757.214193954723;2758.3104223944015;2758.7103354147725;2633.2758491414825;2643.8942442302287;2676.0767535200325;2721.727827217282;2731.8224315419434;2684.838909665407;2716.7283271672673;2720.279126031603;2736.767374773127;2749.848758318292;14914.925425372912;15223.923880380638;15234.619134521725;15260.236988150658;15262.31319590621;7990.440669153161;8294.543800090993;8304.875426868603;8305.37709671777;8305.66777328906;5179.766910489037;5309.442508536626;5490.478404551562;5582.441755824385;5616.66300022;1889.5653999580036;1939.7284380186786;1940.5439721665398;1970.123295133666;1986.662267414543;27244.182674519798;27248.727512724818;27445.725542744516;27461.45077098467;27487.587686184725;6904.585724856524;6965.303469653096;6984.126984126984;7020.368166864904;7154.320339567733;17679.823201768075;17710.822891770917;17744.556386090193;17762.28950841952;17794;7858.410619203582;8064.354851611857;8112.675492980333;8120.75637730869;8164.428490005643;7269.127704675473;7442.106947166375;7445.218252083453;7500.024996750497;7528.397728181732;5168.483151684876;5350;5373.570114390917;5373.892522149535;5417.26866872975;1556.8910176287552;1563.0621627023922;1572.4968010236614;1587.4590733207751;1589.666170104291;825.2119226139023;830.3440282177013;855.0978717453022;857.8027053777666;858.5449711652834;6873.553219040747;6893.20728116273;6895.103636527219;6927.58434493932;7091.751788687371;714.6498215874184;718.9209186989427;720.0711082703255;721.1382398034299;726.7674344209908;4346.5653434656915;4364.519902810688;4421.292593185075;4475.910481790346;4680.9297860532115;21292.680609790867;21394.35816925495;22412.77587224107;22439.775602243768;22503.099876005104;21677.132914683552;22157.77842221557;22306;22313.21903733394;22536.323910282717;11439.37083460401;11462.656120316404;11674.416279186007;11687.065034797195;11708.941455292668;7797.465823607237;7809.843803124019;7817.765467035998;7837.843243134991;7956.681732730857;18409.737117773126;18658.906705466386;18931.71602425937;19034.904825475784;19115.522111947314;19423.12595933158;19434.2226310946;19547.120379583237;19740.573574053316;19746.60506789885;11225.943870280596;11430.1998860079;11593.304401735923;11593.536258549564;11601.071914246671;14006.78989815174;14124.2937853109;14188;14248.786268205778;14279.71440571162;11225.887741122811;11228;11486.138539609396;11526.94236528812;11648.94175529117;11203.15976301797;11304.208705390873;11366.829497557377;11433.828492572784;11495.942520287344;9204.815903682023;9267.165955063807;9506.904930950603;9512.191463725661;9516.95241523788;7155.908342069667;7310.707571697072;7357.926420735724;7440.776776696708;7513.924860751541;6906.827329316607;6916.965415172892;7024.789256322319;7027.859442811217;7134.821629459305 17:03:05 INFO - PID 17040 | |4;prototype.html;501.557415387065;529.8145649022845;540.7539569495879;545.7107732901561;553.2834978702581;6401.167848179736;6468.191476065492;6504.609723416598;6521.347865213476;6551.8034458966185;6348.36516348365;6381.425671689547;6392.296847346788;6403.23161220653;6414.294427612959;5236.266922630815;5240.580753539727;5250.501202385767;5258.737063146847;5339.893202135955;4952.356193694833;5081.085404627184;5268.841934741964;5321.866953326178;5322.387925388591;5032.521910418504;5065.088284108859;5094.821681241157;5101.285819985205;5111.1566591512355;5061.44324124346;5091.2108623163285;5113.411957624883;5127.589792816566;5147.459516750762;4505.819767209307;4596.402467679214;4602.240630295997;4604.240300350438;4611.838585649486;6287.339829317947;6291.779787707408;6299.811005669837;6304.747810087591;6323.399277068671;5722.97138514309;5776.880484538344;5820.912686309709;5842.152887831241;5876.794312199053;6735.158105236846;6740.898886516707;6759.898601520981;6782.8304292392595;6800.761973330909;5005.499450055002;5071.315372424712;5073.568746656539;5076.314697515825;5086.567641750456;6728.529002969794;6891.448684105309;6961.338672826073;7016.368526832507;7023.192332881733;5086.033653605877;5098.898022039612;5113.565346945476;5115.104856650071;5126;5143.537081662668;5221.530062294411;5223.563520031946;5252.579793616502;5275.657082289639;5743.483086522233;5811.302643682785;5832.62087964281;5848.385919478478;5874.325817142094;6745.392914637706;6767.018782276542;6785.321467853175;6827.078344423439;6849.349311815369;1769.8053214146435;1786.7409225662207;1805.4222648752273;1807.8192180781816;1819.6360727854217;1206.5869997490347;1241.7081985733346;1247.9563215287603;1260.615512268767;1268.7906495428151;5753.367129615739;5763.9135412968835;5800.6809625471005;5808.311722056525;5832.1834943108;6782.152230971129;6918.584884906922;6923;6937.965310173417;6954.130733658293;5754.9424505754405;5799.333076696234;5850.736716847752;5851.824445266649;5853.356130825606;3457.27397246576;3569.5181150544863;3615.9819200903826;3625.148090198801;3663.6153203913736;6513.804585862432;6584;6605.471562275006;6611.743663787301;6635.900461493082;6903;6985.860282794417;7001.299870012958;7004.824879378057;7015.018617087718;6545.9018114728315;6550.181227346582;6556.836079097965;6565.540412171198;6572.901406478906;6701.631410272482;6763.222229443677;6824.624645644339;6827.6244806536115;6836.248012718696;6713.462922966249;6727.755365257443;6800.217974932946;6804.251532331538;6870.931290687229;6485.383888530582;6530.608163510205;6571.769988050395;6613.371729685672;6641.667916604054;5043.319151914445;5056.6207534434325;5080.593552515864;5110.770015349244;5123.410807757155;6563.1796025496815;6579.703913323816;6620.735170593122;6647.734090636321;6698.363655452724;6449.903251451138;6573.605583664996;6599.901001485077;6649.534532582867;6696.296888826603;6521.771722997147;6532.41208291256;6535.967320163369;6561.901571476336;6641.070250164884;6373.5857169283845;6413.819301437534;6517.967410162919;6534.444572211225;6625.536212465081;6589.27517973013;6598.8350291243105;6680.4989625779235;6690.230623478362;6731.865362692621;6357.491400688026;6375.808725738235;6395.42441180296;6412.210688350582;6421.93578064232 17:03:05 INFO - PID 17040 | |5;yui.html;899.7300809757071;907.5280853955943;931.97017295888;940.8588711693245;945.9621615135395;19482.610347793037;20391.796082039175;20394.286199982984;20421;20445.897770511165;17751.28994840205;17803.109844507788;17970.730439043426;18773.436796896116;18984.620307593876;979.662016604274;992.9652462163825;995.0845222395377;995.7311525888006;996.0686757881404;957.2963871554402;996.8155891160122;1001.7245257554158;1002.8746406699163;1008.6822650864954;1059.0838924330476;1062.1874266186373;1065.9307145035586;1066.9679909602723;1069.636323649959;980.6077568972397;1043.7390652336917;1054.910332621728;1056;1056.0601065052072;738.9408847292203;748.5433885329944;749.1646813802571;749.8612756640039;750.4446709435033;20525.589488210302;20734.688979665316;20740.688889666668;20781.896090519604;20794.792052079436;21681.132754689792;22137.44656383587;22433.32700019002;22587.548249034928;22622.09511619533;15492.147931863743;16064.27710753019;16102.5974350641;16197.4330898418;16199.1090490023;3728.720345974036;3777.244551089793;3795.62043795621;3799.601041890617;3810.618938106167;129458;130484.3475782615;130721;131045.34477327648;132819.33590331988;16750.329986800636;16888.493345199662;16947.237374318185;17086.40197593078;17216.397426090025;31235.531467028013;31489;31523.842380787948;31541.84229078886;31730;8749.300055995505;8796.824063518694;8815.118488151262;8818.206361427503;8829.911700882909;4392.472903251631;4434.977825110918;4474.463064432224;4482.9913269514755;4505.594496495331;5483.862903427446;5542.944570554324;5571.916421253684;5572.693501857356;5582.441755824385;919.9862002069974;937.9437233765996;950.9857352139724;955.3599088610648;958.3531116496337;692.8233300508338;710.5167439797939;714.0538786108427;730.82825535999;732.2531018361242;11992.763762843448;12309.753804923852;12783.360831958365;13067.607971760863;13486.12340197884;709.2836235402177;711.1714852197132;714.1501613080418;721.487743701967;729.2270193594807;5521.779128834802;5583.776648933997;5624.465675760796;5671.546276297886;5674.943250567524;117636;120464;122110;122249;123767;104665;105750.4712476448;106746;106988.72045118109;109665;91451.54274228586;92210.07789922149;93354.53322733479;94175;94842;10214.489275536342;10377.688669339932;10450.738731531772;10553.577856885639;10568.154547636324;43638.34542481802;44742.55257447384;45363.77318113388;46081;46757.766211170085;55572.72213638906;56898.43101568931;57048.429515705975;57685.42314576801;58296.4170358291;15825.129617871127;16148.67702645964;16162.111083890028;16336.754948676016;16383.426580069641;16672.666546669243;16810;16859.409920652717;16963.321467141177;16974.49076527706;16883.155842207594;16943.830561694227;16976.490705278862;17037.38144876235;17149.142542873054;15764.842351576795;15784.842151578796;16029.278682459084;16069.11619860872;16270.51188464348;15449.922750386626;15455.459058932884;15534.067955922681;15580;15682.76475852886;11776.234544754563;11926.761464770829;11934.164608477324;11964.102692297938;12124.787521247805;11907.642770716546;12003.459844306852;12081.154319197572;12156.209846359958;12274.938625306817 17:03:05 INFO - PID 17040 | __end_tp_report 17:03:05 INFO - PID 17040 | __start_cc_report 17:03:05 INFO - PID 17040 | _x_x_mozilla_cycle_collect,271 17:03:05 INFO - PID 17040 | __end_cc_report 17:03:05 INFO - PID 17040 | __startTimestamp1506556985897__endTimestamp 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | ------- Summary: start ------- 17:03:05 INFO - PID 17040 | Number of tests: 6 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | [#0] dojo.html Cycles:165 Average:6302.21 Median:6609.34 stddev:792.74 (12.0%) stddev-sans-first:758.45 17:03:05 INFO - PID 17040 | Values: 3262.1 3291.3 3294.7 3308.7 3308.7 6272.0 6362.0 6494.3 6496.3 6499.1 6313.1 6358.7 6433.7 6525.5 6553.4 5843.0 5940.0 5946.0 5947.5 5983.2 5762.5 5874.5 5947.4 6009.7 6018.8 5881.5 5916.5 5930.3 5935.0 6030.2 5747.2 5801.2 5830.4 5855.9 5862.8 5828.9 5837.9 5844.1 5874.2 5894.1 6348.4 6383.0 6390.2 6428.6 6524.3 6677.8 6785.4 6883.7 6939.4 6965.4 6840.4 6847.2 6858.4 6860.2 6865.3 6247.7 6330.1 6333.4 6339.5 6340.2 7005.3 7011.4 7029.3 7123.9 7171.7 6716.9 6797.6 6803.7 6817.1 6828.9 6884.1 6893.0 6944.0 6991.2 7025.4 6664.3 6744.4 6783.6 6793.9 6794.6 6941.2 6943.8 6945.3 6963.8 6977.8 5006.3 5065.1 5072.3 5073.6 5074.0 4374.7 4388.6 4420.8 4421.6 4429.2 5779.6 5815.9 5832.5 5842.4 5905.6 6787.8 6812.9 6913.8 6915.4 6920.2 5840.6 5925.1 5930.3 5959.9 5973.8 5834.1 5881.1 5919.4 5926.8 5967.9 6614.8 6637.0 6668.4 6727.6 6736.7 6704.8 6833.9 6855.5 6957.2 6968.5 6609.3 6686.2 6695.6 6717.8 6760.0 6799.9 6828.1 6881.1 6903.1 6903.1 6923.1 6944.3 7024.5 7028.2 7031.8 6519.7 6633.2 6646.1 6746.8 6755.5 6615.6 6704.6 6714.3 6720.6 6744.9 6587.0 6685.4 6686.4 6699.8 6706.1 6747.2 6758.7 6830.3 6830.8 6847.8 6363.0 6446.1 6448.6 6483.7 6589.8 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | [#1] ext.html Cycles:180 Average:37437.26 Median:3604.51 stddev:52718.12 (1462.6%) stddev-sans-first:52794.43 17:03:05 INFO - PID 17040 | Values: 851.7 872.8 874.1 875.1 875.8 40695.6 41449.2 41606.0 41608.4 41709.6 37695.4 37953.0 38024.0 38036.6 38052.2 6885.3 7323.8 7327.0 7335.6 7336.1 7195.9 7243.5 7267.7 7303.9 7310.6 7236.2 7266.9 7957.5 8157.3 8165.0 8072.6 8141.8 8142.8 8148.4 8152.6 7905.5 7940.4 8003.3 8024.8 8033.1 38430.6 38697.2 38780.8 38786.2 38984.2 3543.4 3595.4 3600.6 3604.1 3604.9 32053.8 32106.0 32275.2 32382.0 32423.5 5050.3 5260.2 5268.8 5275.2 5299.5 189764.0 190434.0 190615.0 190990.0 191395.0 42570.8 43171.0 48787.0 49220.5 49681.0 51785.2 51786.5 51816.5 51838.2 51864.0 15283.9 15380.2 15447.0 15464.4 15478.9 12359.0 12361.6 12413.6 12547.9 12603.0 14446.5 14474.2 14527.3 14562.1 14587.9 5746.7 5798.5 5814.9 5999.2 6034.2 1025.6 1033.2 1040.8 1048.3 1049.4 23005.3 23061.7 23231.8 23268.8 23349.2 1114.0 1136.6 1137.4 1137.6 1146.6 12147.2 12327.6 12361.4 12366.9 12372.6 221962.0 222334.0 223439.0 223441.0 224264.0 52211.7 52359.7 52398.2 52496.7 52605.7 1438.4 1464.5 1483.9 1485.7 1490.7 22278.0 22372.2 22522.5 22585.7 22709.2 36719.3 36812.4 36879.6 36944.3 36951.6 194951.0 195326.0 196021.0 196596.0 196869.0 33611.8 35654.8 36388.6 36570.3 36574.6 43681.0 45027.3 45123.8 45257.3 45450.3 32982.8 33077.7 33276.5 33589.0 33718.0 33416.7 33447.7 33476.3 33530.3 33694.5 37226.0 37285.8 37480.3 37520.1 37693.2 31848.4 32463.5 32610.0 32670.8 32686.7 23892.9 24426.6 24515.4 24820.5 25113.0 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | [#2] jquery.html Cycles:180 Average:36119.34 Median:22347.39 stddev:85107.43 (380.8%) stddev-sans-first:85304.34 17:03:05 INFO - PID 17040 | Values: 578.9 588.6 596.3 598.0 600.9 22533.4 23237.5 23374.6 23394.9 23430.5 23144.8 24644.1 24817.6 24980.4 25064.4 6632.4 6795.3 6813.4 6815.4 6828.9 6366.9 6620.5 6680.2 6783.3 6796.7 6586.2 6591.0 6595.7 6597.5 6600.2 6567.6 6599.0 6603.1 6606.6 6607.2 6093.4 6936.2 7233.6 7264.3 7286.3 29919.1 30330.4 30561.0 30624.2 30637.4 2065.3 2072.4 2085.1 2097.4 2099.9 19948.3 20619.4 20911.3 20959.5 21127.5 2546.3 2564.8 2584.0 2618.2 2655.4 128266.0 132977.0 140334.0 144508.0 151123.2 19488.8 20777.9 21355.9 22122.9 22445.6 42637.8 42712.6 42732.0 42889.0 42903.0 10719.1 10784.2 10803.9 10937.4 10970.2 8807.8 8873.5 8923.9 8941.8 8947.9 10881.3 11350.6 11573.7 11599.6 11853.5 4074.9 4092.9 4253.1 4303.5 4439.0 941.8 952.9 964.1 972.8 976.7 19217.2 19253.9 19578.8 19629.9 19712.8 1015.1 1017.1 1020.3 1025.5 1028.8 10396.2 10488.3 10570.8 10861.9 10861.9 486929.0 494456.0 507195.0 518031.0 533714.0 105612.5 106939.0 107668.0 107974.0 113916.4 1144.1 1155.3 1181.4 1184.4 1186.0 16602.4 17181.3 17299.3 17467.6 17554.2 53974.5 54526.0 54976.7 55028.0 56700.0 69504.0 69749.7 70298.0 70384.6 70466.3 19282.0 19401.6 19572.8 19739.8 19778.2 22180.9 22257.4 22437.3 22557.8 22569.8 17733.9 17823.6 17877.6 17988.5 17989.1 15162.8 15754.4 15818.7 15938.9 16198.8 18552.4 18562.1 18825.5 18836.9 19057.5 18929.1 19273.7 19358.7 19431.6 19507.0 17722.7 17914.9 17943.9 18047.8 18049.5 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | [#3] mootools.html Cycles:180 Average:9424.50 Median:14989.33 stddev:6899.13 (46.0%) stddev-sans-first:6891.57 17:03:05 INFO - PID 17040 | Values: 1314.3 1344.9 1371.9 1372.9 1378.9 15395.7 16066.4 16079.7 16084.0 16086.8 15615.1 15689.3 15731.8 15752.0 15767.4 2733.7 2838.7 2840.2 2841.1 2843.8 2687.5 2711.3 2770.6 2784.5 2785.0 2729.9 2757.0 2757.2 2758.3 2758.7 2633.3 2643.9 2676.1 2721.7 2731.8 2684.8 2716.7 2720.3 2736.8 2749.8 14914.9 15223.9 15234.6 15260.2 15262.3 7990.4 8294.5 8304.9 8305.4 8305.7 5179.8 5309.4 5490.5 5582.4 5616.7 1889.6 1939.7 1940.5 1970.1 1986.7 27244.2 27248.7 27445.7 27461.5 27487.6 6904.6 6965.3 6984.1 7020.4 7154.3 17679.8 17710.8 17744.6 17762.3 17794.0 7858.4 8064.4 8112.7 8120.8 8164.4 7269.1 7442.1 7445.2 7500.0 7528.4 5168.5 5350.0 5373.6 5373.9 5417.3 1556.9 1563.1 1572.5 1587.5 1589.7 825.2 830.3 855.1 857.8 858.5 6873.6 6893.2 6895.1 6927.6 7091.8 714.6 718.9 720.1 721.1 726.8 4346.6 4364.5 4421.3 4475.9 4680.9 21292.7 21394.4 22412.8 22439.8 22503.1 21677.1 22157.8 22306.0 22313.2 22536.3 11439.4 11462.7 11674.4 11687.1 11708.9 7797.5 7809.8 7817.8 7837.8 7956.7 18409.7 18658.9 18931.7 19034.9 19115.5 19423.1 19434.2 19547.1 19740.6 19746.6 11225.9 11430.2 11593.3 11593.5 11601.1 14006.8 14124.3 14188.0 14248.8 14279.7 11225.9 11228.0 11486.1 11526.9 11648.9 11203.2 11304.2 11366.8 11433.8 11495.9 9204.8 9267.2 9506.9 9512.2 9517.0 7155.9 7310.7 7357.9 7440.8 7513.9 6906.8 6917.0 7024.8 7027.9 7134.8 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | [#4] prototype.html Cycles:180 Average:5618.56 Median:6352.93 stddev:1562.19 (24.6%) stddev-sans-first:1518.63 17:03:05 INFO - PID 17040 | Values: 501.6 529.8 540.8 545.7 553.3 6401.2 6468.2 6504.6 6521.3 6551.8 6348.4 6381.4 6392.3 6403.2 6414.3 5236.3 5240.6 5250.5 5258.7 5339.9 4952.4 5081.1 5268.8 5321.9 5322.4 5032.5 5065.1 5094.8 5101.3 5111.2 5061.4 5091.2 5113.4 5127.6 5147.5 4505.8 4596.4 4602.2 4604.2 4611.8 6287.3 6291.8 6299.8 6304.7 6323.4 5723.0 5776.9 5820.9 5842.2 5876.8 6735.2 6740.9 6759.9 6782.8 6800.8 5005.5 5071.3 5073.6 5076.3 5086.6 6728.5 6891.4 6961.3 7016.4 7023.2 5086.0 5098.9 5113.6 5115.1 5126.0 5143.5 5221.5 5223.6 5252.6 5275.7 5743.5 5811.3 5832.6 5848.4 5874.3 6745.4 6767.0 6785.3 6827.1 6849.3 1769.8 1786.7 1805.4 1807.8 1819.6 1206.6 1241.7 1248.0 1260.6 1268.8 5753.4 5763.9 5800.7 5808.3 5832.2 6782.2 6918.6 6923.0 6938.0 6954.1 5754.9 5799.3 5850.7 5851.8 5853.4 3457.3 3569.5 3616.0 3625.1 3663.6 6513.8 6584.0 6605.5 6611.7 6635.9 6903.0 6985.9 7001.3 7004.8 7015.0 6545.9 6550.2 6556.8 6565.5 6572.9 6701.6 6763.2 6824.6 6827.6 6836.2 6713.5 6727.8 6800.2 6804.3 6870.9 6485.4 6530.6 6571.8 6613.4 6641.7 5043.3 5056.6 5080.6 5110.8 5123.4 6563.2 6579.7 6620.7 6647.7 6698.4 6449.9 6573.6 6599.9 6649.5 6696.3 6521.8 6532.4 6536.0 6561.9 6641.1 6373.6 6413.8 6518.0 6534.4 6625.5 6589.3 6598.8 6680.5 6690.2 6731.9 6357.5 6375.8 6395.4 6412.2 6421.9 17:03:05 INFO - PID 17040 | 17:03:05 INFO - PID 17040 | [#5] yui.html Cycles:180 Average:24044.70 Median:20433.45 stddev:34135.15 (167.1%) stddev-sans-first:34186.66 17:03:05 INFO - PID 17040 | Values: 899.7 907.5 932.0 940.9 946.0 19482.6 20391.8 20394.3 20421.0 20445.9 17751.3 17803.1 17970.7 18773.4 18984.6 979.7 993.0 995.1 995.7 996.1 957.3 996.8 1001.7 1002.9 1008.7 1059.1 1062.2 1065.9 1067.0 1069.6 980.6 1043.7 1054.9 1056.0 1056.1 738.9 748.5 749.2 749.9 750.4 20525.6 20734.7 20740.7 20781.9 20794.8 21681.1 22137.4 22433.3 22587.5 22622.1 15492.1 16064.3 16102.6 16197.4 16199.1 3728.7 3777.2 3795.6 3799.6 3810.6 129458.0 130484.3 130721.0 131045.3 132819.3 16750.3 16888.5 16947.2 17086.4 17216.4 31235.5 31489.0 31523.8 31541.8 31730.0 8749.3 8796.8 8815.1 8818.2 8829.9 4392.5 4435.0 4474.5 4483.0 4505.6 5483.9 5542.9 5571.9 5572.7 5582.4 920.0 937.9 951.0 955.4 958.4 692.8 710.5 714.1 730.8 732.3 11992.8 12309.8 12783.4 13067.6 13486.1 709.3 711.2 714.2 721.5 729.2 5521.8 5583.8 5624.5 5671.5 5674.9 117636.0 120464.0 122110.0 122249.0 123767.0 104665.0 105750.5 106746.0 106988.7 109665.0 91451.5 92210.1 93354.5 94175.0 94842.0 10214.5 10377.7 10450.7 10553.6 10568.2 43638.3 44742.6 45363.8 46081.0 46757.8 55572.7 56898.4 57048.4 57685.4 58296.4 15825.1 16148.7 16162.1 16336.8 16383.4 16672.7 16810.0 16859.4 16963.3 16974.5 16883.2 16943.8 16976.5 17037.4 17149.1 15764.8 15784.8 16029.3 16069.1 16270.5 15449.9 15455.5 15534.1 15580.0 15682.8 11776.2 11926.8 11934.2 11964.1 12124.8 11907.6 12003.5 12081.2 12156.2 12274.9 17:03:05 INFO - PID 17040 | -------- Summary: end -------- 17:03:05 INFO - PID 17040 | 17:03:06 INFO - TEST-INFO | 17040: exit 0 17:03:06 INFO - TEST-OK | dromaeo_css | took 1109670ms 17:03:06 INFO - TEST-START | kraken 17:03:06 INFO - Initialising browser for kraken test... 17:03:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52656/getInfo.html -profile /tmp/tmp9JPSIx/profile 17:03:06 INFO - TEST-INFO | started process 17395 (/builds/slave/test/build/application/firefox/firefox http://localhost:52656/getInfo.html) 17:03:11 INFO - TEST-INFO | 17395: exit 0 17:03:11 INFO - Browser initialized. 17:03:11 INFO - Running cycle 1/1 for kraken test... 17:03:11 INFO - Using env: {'DISPLAY': ':0', 17:03:11 INFO - 'HOME': '/home/cltbld', 17:03:11 INFO - 'JSGC_DISABLE_POISONING': '1', 17:03:11 INFO - 'LANG': 'en_US.UTF-8', 17:03:11 INFO - 'LANGUAGE': 'en_US:en', 17:03:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:03:11 INFO - 'LOGNAME': 'cltbld', 17:03:11 INFO - 'MAIL': '/var/mail/cltbld', 17:03:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:03:11 INFO - 'MOZ_CRASHREPORTER': '1', 17:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:03:11 INFO - 'MOZ_NO_REMOTE': '1', 17:03:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:11 INFO - 'NO_EM_RESTART': '1', 17:03:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:11 INFO - 'PWD': '/builds/slave/test', 17:03:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:11 INFO - 'RUST_BACKTRACE': 'full', 17:03:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:03:11 INFO - 'SHELL': '/bin/bash', 17:03:11 INFO - 'SHLVL': '1', 17:03:11 INFO - 'STYLO_FORCE_DISABLED': '1', 17:03:11 INFO - 'TERM': 'linux', 17:03:11 INFO - 'TMOUT': '86400', 17:03:11 INFO - 'USER': 'cltbld', 17:03:11 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412', 17:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:11 INFO - '_': '/tools/buildbot/bin/python'} 17:03:11 INFO - TEST-INFO | started process 17628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9JPSIx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:12 INFO - PID 17628 | 17:03:12 INFO - PID 17628 | (/builds/slave/test/build/application/firefox/firefox:17677): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:03:12 INFO - PID 17628 | 17:03:22 INFO - PID 17628 | RSS: Main: 153620480 17:03:22 INFO - PID 17628 | 17:03:25 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52656/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:26 INFO - PID 17628 | RSS: Main: 158924800 17:03:26 INFO - PID 17628 | 17:03:28 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52656/tests/kraken/driver.html?testName=audio-dft) 17:03:29 INFO - PID 17628 | RSS: Main: 159531008 17:03:29 INFO - PID 17628 | 17:03:32 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52656/tests/kraken/driver.html?testName=audio-fft) 17:03:33 INFO - PID 17628 | RSS: Main: 155586560 17:03:33 INFO - PID 17628 | 17:03:35 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52656/tests/kraken/driver.html?testName=audio-oscillator) 17:03:35 INFO - PID 17628 | RSS: Main: 155947008 17:03:35 INFO - PID 17628 | 17:03:37 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:38 INFO - PID 17628 | RSS: Main: 156864512 17:03:38 INFO - PID 17628 | 17:03:41 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52656/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:42 INFO - PID 17628 | RSS: Main: 159117312 17:03:42 INFO - PID 17628 | 17:03:45 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52656/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:46 INFO - PID 17628 | RSS: Main: 159641600 17:03:46 INFO - PID 17628 | 17:03:49 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52656/tests/kraken/driver.html?testName=json-parse-financial) 17:03:50 INFO - PID 17628 | RSS: Main: 159588352 17:03:50 INFO - PID 17628 | 17:03:51 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:52 INFO - PID 17628 | RSS: Main: 159326208 17:03:52 INFO - PID 17628 | 17:03:53 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:54 INFO - PID 17628 | RSS: Main: 159592448 17:03:54 INFO - PID 17628 | 17:03:56 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:57 INFO - PID 17628 | RSS: Main: 156389376 17:03:57 INFO - PID 17628 | 17:03:59 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:00 INFO - PID 17628 | RSS: Main: 156753920 17:04:00 INFO - PID 17628 | 17:04:03 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:04 INFO - PID 17628 | RSS: Main: 156971008 17:04:04 INFO - PID 17628 | 17:04:05 INFO - PID 17628 | Cycle 1(1): loaded http://localhost:52656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52656/tests/kraken/driver.html?testName=ai-astar) 17:04:06 INFO - PID 17628 | RSS: Main: 158171136 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | __start_tp_report 17:04:06 INFO - PID 17628 | _x_x_mozilla_page_load 17:04:06 INFO - PID 17628 | _x_x_mozilla_page_load_details 17:04:06 INFO - PID 17628 | |i|pagename|runs| 17:04:06 INFO - PID 17628 | |0;ai-astar;109;108;106;106;107;108;106;107;108;108 17:04:06 INFO - PID 17628 | |1;audio-beat-detection;122;116;119;117;121;116;149;119;117;139 17:04:06 INFO - PID 17628 | |2;audio-dft;165;162;164;162;163;163;162;167;167;164 17:04:06 INFO - PID 17628 | |3;audio-fft;77;84;74;75;73;74;75;75;75;74 17:04:06 INFO - PID 17628 | |4;audio-oscillator;81;80;79;80;79;78;79;78;78;79 17:04:06 INFO - PID 17628 | |5;imaging-gaussian-blur;113;114;114;111;113;114;114;114;114;113 17:04:06 INFO - PID 17628 | |6;imaging-darkroom;151;147;147;148;148;147;147;147;148;147 17:04:06 INFO - PID 17628 | |7;imaging-desaturate;96;94;95;96;100;96;96;96;94;95 17:04:06 INFO - PID 17628 | |8;json-parse-financial;53;53;54;54;54;55;54;55;55;54 17:04:06 INFO - PID 17628 | |9;json-stringify-tinderbox;39;38;39;39;39;38;39;39;39;39 17:04:06 INFO - PID 17628 | |10;stanford-crypto-aes;71;71;73;82;72;74;72;73;71;74 17:04:06 INFO - PID 17628 | |11;stanford-crypto-ccm;111;112;121;110;107;121;109;117;109;121 17:04:06 INFO - PID 17628 | |12;stanford-crypto-pbkdf2;177;163;167;178;166;166;165;163;177;167 17:04:06 INFO - PID 17628 | |13;stanford-crypto-sha256-iterative;69;67;64;64;67;64;63;67;67;70 17:04:06 INFO - PID 17628 | __end_tp_report 17:04:06 INFO - PID 17628 | __start_cc_report 17:04:06 INFO - PID 17628 | _x_x_mozilla_cycle_collect,743 17:04:06 INFO - PID 17628 | __end_cc_report 17:04:06 INFO - PID 17628 | __startTimestamp1506557046166__endTimestamp 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | ------- Summary: start ------- 17:04:06 INFO - PID 17628 | Number of tests: 14 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#0] ai-astar Cycles:10 Average:107.30 Median:108.00 stddev:1.06 (1.0%) stddev-sans-first:0.93 17:04:06 INFO - PID 17628 | Values: 109.0 108.0 106.0 106.0 107.0 108.0 106.0 107.0 108.0 108.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:120.00 stddev:11.24 (9.4%) stddev-sans-first:11.91 17:04:06 INFO - PID 17628 | Values: 122.0 116.0 119.0 117.0 121.0 116.0 149.0 119.0 117.0 139.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.91 (1.2%) stddev-sans-first:1.99 17:04:06 INFO - PID 17628 | Values: 165.0 162.0 164.0 162.0 163.0 163.0 162.0 167.0 167.0 164.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#3] audio-fft Cycles:10 Average:75.60 Median:75.00 stddev:3.13 (4.2%) stddev-sans-first:3.28 17:04:06 INFO - PID 17628 | Values: 77.0 84.0 74.0 75.0 73.0 74.0 75.0 75.0 75.0 74.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:0.78 17:04:06 INFO - PID 17628 | Values: 81.0 80.0 79.0 80.0 79.0 78.0 79.0 78.0 78.0 79.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 17:04:06 INFO - PID 17628 | Values: 113.0 114.0 114.0 111.0 113.0 114.0 114.0 114.0 114.0 113.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:0.50 17:04:06 INFO - PID 17628 | Values: 151.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.69 (1.8%) stddev-sans-first:1.79 17:04:06 INFO - PID 17628 | Values: 96.0 94.0 95.0 96.0 100.0 96.0 96.0 96.0 94.0 95.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 17:04:06 INFO - PID 17628 | Values: 53.0 53.0 54.0 54.0 54.0 55.0 54.0 55.0 55.0 54.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 17:04:06 INFO - PID 17628 | Values: 39.0 38.0 39.0 39.0 39.0 38.0 39.0 39.0 39.0 39.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:3.27 (4.5%) stddev-sans-first:3.36 17:04:06 INFO - PID 17628 | Values: 71.0 71.0 73.0 82.0 72.0 74.0 72.0 73.0 71.0 74.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:114.50 stddev:5.61 (4.9%) stddev-sans-first:5.86 17:04:06 INFO - PID 17628 | Values: 111.0 112.0 121.0 110.0 107.0 121.0 109.0 117.0 109.0 121.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:167.00 stddev:5.99 (3.6%) stddev-sans-first:5.59 17:04:06 INFO - PID 17628 | Values: 177.0 163.0 167.0 178.0 166.0 166.0 165.0 163.0 177.0 167.0 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:2.35 (3.5%) stddev-sans-first:2.26 17:04:06 INFO - PID 17628 | Values: 69.0 67.0 64.0 64.0 67.0 64.0 63.0 67.0 67.0 70.0 17:04:06 INFO - PID 17628 | -------- Summary: end -------- 17:04:06 INFO - PID 17628 | 17:04:06 INFO - PID 17628 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:04:06 INFO - TEST-INFO | 17628: exit 0 17:04:06 INFO - TEST-OK | kraken | took 60394ms 17:04:06 INFO - SUITE-END | took 1170s 17:04:06 INFO - Completed test suite (00:19:30) 17:04:06 INFO - javascript benchmark 17:04:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8663.355545196675, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.054004338741, 3291.2923721399893, 3294.7199488043507, 3308.652591477893, 3308.718758905493, 6271.968640156792, 6362.04569314603, 6494.253160886499, 6496.285408605049, 6499.057636642684, 6313.053042043684, 6358.650274234915, 6433.678316084189, 6525.510586706004, 6553.442957348631, 5843.0, 5939.970300148493, 5945.970270148643, 5947.464728174464, 5983.1623572699855, 5762.510186634141, 5874.471297583216, 5947.375525569818, 6009.699515024253, 6018.8495287617725, 5881.500072493843, 5916.497097746696, 5930.288365396159, 5934.970325148347, 6030.155778191035, 5747.1666608341975, 5801.187833703285, 5830.4461076197695, 5855.941440585582, 5862.765489380419, 5828.854278643068, 5837.854053648651, 5844.094165404369, 5874.1776151338845, 5894.145348924382, 6348.428641422248, 6383.0, 6390.233172019341, 6428.646424446653, 6524.314946930599, 6677.833054173636, 6785.423239024689, 6883.690233939485, 6939.444844412435, 6965.442764578822, 6840.384365407137, 6847.17833859935, 6858.417034552069, 6860.176778786527, 6865.313468653145, 6247.656378899204, 6330.145430366888, 6333.398327158912, 6339.492840572743, 6340.239171299428, 7005.334493223238, 7011.404030657349, 7029.261927497641, 7123.857522849514, 7171.677274522659, 6716.899246511306, 6797.5581587196675, 6803.727850886008, 6817.11377520929, 6828.863422731617, 6884.139482564679, 6892.965535172292, 6943.9652801735665, 6991.196012458632, 7025.367716905401, 6664.333566643297, 6744.359285867835, 6783.59298442095, 6793.932060679429, 6794.626295553792, 6941.167059952737, 6943.826404339932, 6945.305469453116, 6963.825904352431, 6977.79066628002, 5006.324146240284, 5065.088284108896, 5072.340595722532, 5073.619478539124, 5074.035933172685, 4374.650027997816, 4388.626966707801, 4420.823167073281, 4421.624161946271, 4429.247028005247, 5779.566532509994, 5815.854603634943, 5832.533397328203, 5842.415758424124, 5905.6161349513, 6787.830304242433, 6812.897806532906, 6913.792586222421, 6915.4121899638085, 6920.204176519765, 5840.620359676607, 5925.05199168131, 5930.318013428425, 5959.880802383928, 5973.820785376446, 5834.066549352084, 5881.088431293157, 5919.378465261172, 5926.822195334147, 5967.880642387215, 6614.801555953329, 6637.0, 6668.399844014062, 6727.62998035103, 6736.730530778812, 6704.83237919056, 6833.897491537531, 6855.451563874978, 6957.1651401832105, 6968.477364197604, 6609.339066093352, 6686.197656281277, 6695.631740254333, 6717.764878229238, 6760.0, 6799.93200067993, 6828.146481689789, 6881.10545629065, 6903.0680858083515, 6903.102596662402, 6923.134608173978, 6944.270851560514, 7024.5434046786795, 7028.156621205488, 7031.824204394931, 6519.706613202512, 6633.237177724431, 6646.069550263063, 6746.831329216809, 6755.527113102232, 6615.56998795096, 6704.564203326768, 6714.261431242657, 6720.563163394364, 6744.898826517508, 6587.0, 6685.431738302299, 6686.364795344434, 6699.799006029827, 6706.094677218513, 6747.156605424322, 6758.662066896733, 6830.282820303796, 6830.795076147723, 6847.828804279933, 6362.9681851592295, 6446.0975463434215, 6448.64532450701, 6483.675816209076, 6589.769358072636], "value": 6239.925193539337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.723189963262, 872.8297981893529, 874.0865795243969, 875.1161327059664, 875.7679215008023, 40695.59304406955, 41449.17101657965, 41606.0, 41608.37587436191, 41709.58290417099, 37695.434568481425, 37953.0, 38024.0, 38036.61963380365, 38052.23895522095, 6885.345892140252, 7323.780286591411, 7326.963365183166, 7335.559866408006, 7336.119665640131, 7195.89206161908, 7243.456740744439, 7267.672954717024, 7303.926960730378, 7310.634468276591, 7236.240194779525, 7266.890996635055, 7957.5225486471, 8157.347412207009, 8164.959175204116, 8072.596370181497, 8141.79645508867, 8142.837143257161, 8148.388870834711, 8152.592370381517, 7905.486143400661, 7940.404469664741, 8003.319717823992, 8024.799380015488, 8033.076196237449, 38430.61569384326, 38697.226055478735, 38780.80609596962, 38786.22427551433, 38984.22031559353, 3543.3976224041976, 3595.3708101082207, 3600.6399360064047, 3604.098975256186, 3604.9279014419567, 32053.839730801195, 32106.0, 32275.19312017195, 32382.0, 32423.51364729531, 5050.292958985745, 5260.210968354778, 5268.841934741964, 5275.235090911796, 5299.49654782795, 189764.0, 190434.0, 190615.0, 190990.0, 191395.0, 42570.78714606469, 43171.0, 48787.0, 49220.507794922305, 49681.0, 51785.22322165171, 51786.48213517892, 51816.48183518116, 51838.22242666363, 51864.0, 15283.923580382027, 15380.15409152485, 15446.995945263521, 15464.381424742884, 15478.922605387126, 12359.011279097651, 12361.567345142877, 12413.627591172279, 12547.874521254671, 12603.0, 14446.494372696905, 14474.203918784568, 14527.346269417902, 14562.053466524641, 14587.927060364631, 5746.655610282477, 5798.478136967693, 5814.941850581525, 5999.160117583542, 6034.215551978303, 1025.5795123999123, 1033.225081189108, 1040.8386700061503, 1048.3447845096814, 1049.4385503755454, 23005.309840704806, 23061.654075188886, 23231.76768232296, 23268.767312327, 23349.182778602666, 1113.9665810025713, 1136.6192325571026, 1137.4199158429096, 1137.5620386151227, 1146.587228597704, 12147.210431322113, 12327.568535101229, 12361.381930903419, 12366.876331236752, 12372.62882113538, 221962.0, 222334.0, 223439.0, 223441.0, 224264.0, 52211.73894130581, 52359.73820130951, 52398.21402678963, 52496.73751631294, 52605.7369713149, 1438.359929831236, 1464.4947493114857, 1483.903546269489, 1485.725140848968, 1490.7316682996948, 22278.0, 22372.216972405888, 22522.5495490086, 22585.661215081458, 22709.205177818698, 36719.26561468809, 36812.44781328336, 36879.63120368762, 36944.261114777015, 36951.630483695895, 194951.0, 195326.0, 196021.0, 196596.0, 196869.0, 33611.83194084014, 35654.821725891205, 36388.636113638524, 36570.26859462849, 36574.634253657125, 43681.0, 45027.32459013052, 45123.774381127885, 45257.32114018226, 45450.31824522701, 32982.835085824416, 33077.66922330746, 33276.50085248772, 33589.0, 33718.0, 33416.66583334136, 33447.66552334543, 33476.33047339088, 33530.329393411506, 33694.49458258177, 37226.0, 37285.81357093197, 37480.2503949914, 37520.061998450255, 37693.246135077694, 31848.36303273968, 32463.513047303837, 32610.0, 32670.83664581662, 32686.673133269313, 23892.88053559721, 24426.63360049565, 24515.387115321548, 24820.503589928463, 25113.0], "value": 17235.806079520913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9421057894208, 588.6203398807767, 596.3053043204667, 597.9701014949252, 600.8918394688956, 22533.436664083405, 23237.535249295004, 23374.649380259267, 23394.94722737479, 23430.531389372245, 23144.768552314472, 24644.137455189073, 24817.627735583934, 24980.375490612743, 25064.373390665198, 6632.436242919345, 6795.286494918037, 6813.420859226947, 6815.352541508573, 6828.897566536506, 6366.93633063668, 6620.536562440631, 6680.164979377578, 6783.253842077367, 6796.660166991655, 6586.209654841426, 6591.044298576728, 6595.736170553196, 6597.472202223835, 6600.174978127734, 6567.638779867106, 6599.0, 6603.14159159311, 6606.603603783764, 6607.2071351438135, 6093.390660933916, 6936.237013928464, 7233.638318084075, 7264.309890560441, 7286.271372862724, 29919.102426927227, 30330.393392132253, 30561.0, 30624.2343941401, 30637.38725225483, 2065.297798748418, 2072.3886453496257, 2085.1450905128822, 2097.4336929029078, 2099.88450635215, 19948.301809436743, 20619.381418557467, 20911.268105616382, 20959.476013099644, 21127.47181320464, 2546.2870396289068, 2564.8332858364147, 2584.0, 2618.2145356393007, 2655.389260470083, 128266.0, 132977.0, 140334.0, 144508.0, 151123.24438377848, 19488.805111948983, 20777.896110519352, 21355.893220534108, 22122.88938555329, 22445.551088978456, 42637.786811065744, 42712.57287427148, 42732.0, 42889.0, 42903.0, 10719.088877445349, 10784.191185661106, 10803.945980270048, 10937.398443085707, 10970.232083754061, 8807.823843523222, 8873.511956842307, 8923.866142007875, 8941.776455588531, 8947.865782013276, 10881.347119172875, 11350.588329184926, 11573.710657233636, 11599.594014209462, 11853.46659400329, 4074.8573799917453, 4092.8567500137947, 4253.065914029572, 4303.526612072669, 4438.977805111019, 941.8351788436996, 952.8523078922778, 964.0841200859212, 972.8103019911049, 976.7167521418709, 19217.231310747415, 19253.90373048126, 19578.804211957697, 19629.901850490656, 19712.802871971384, 1015.1016350529686, 1017.1100287248657, 1020.2501161646184, 1025.4718819807806, 1028.7582418131733, 10396.16830653546, 10488.26582139243, 10570.788584228272, 10861.891381086247, 10861.945690271497, 486929.0, 494456.0, 507195.0, 518031.0, 533714.0, 105612.47193763981, 106939.0, 107668.0, 107974.0, 113916.43041784738, 1144.0618692672097, 1155.3472288157163, 1181.373871847922, 1184.407796101949, 1185.9822102668468, 16602.418915337905, 17181.31274748996, 17299.30802767875, 17467.56331091733, 17554.21006054705, 53974.460255396945, 54526.0, 54976.72511637416, 55028.0, 56700.0, 69504.0, 69749.65125174342, 70298.0, 70384.64807675929, 70466.29533704597, 19282.0, 19401.611967760284, 19572.8042719571, 19739.802601973795, 19778.208871645547, 22180.88909555442, 22257.44356391103, 22437.32688019362, 22557.774422256225, 22569.774302256767, 17733.911330443265, 17823.643527129643, 17877.642447151244, 17988.460346189637, 17989.10054497296, 15162.848371516144, 15754.369825206863, 15818.68362632764, 15938.920305398398, 16198.757018644965, 18552.44342669722, 18562.071896404857, 18825.529361766065, 18836.905815471382, 19057.523561910508, 18929.148188331284, 19273.710894336316, 19358.70961935544, 19431.61136777285, 19507.0, 17722.73415898737, 17914.91042544831, 17943.910280448516, 18047.81952180514, 18049.548761281072], "value": 12763.194788225444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.2705798281952, 1344.8991325650572, 1371.9451221951122, 1372.8764411202992, 1378.9310534473275, 15395.692086158284, 16066.437674681389, 16079.678406431864, 16084.0, 16086.83913160868, 15615.063096214235, 15689.29398177082, 15731.84268157318, 15752.0, 15767.448139315125, 2733.72662733727, 2838.7303206195484, 2840.247334456371, 2841.076650088719, 2843.829370237782, 2687.4759421912736, 2711.2950632835505, 2770.556710926252, 2784.49879021776, 2785.0, 2729.931751706203, 2756.986215068922, 2757.214193954723, 2758.3104223944015, 2758.7103354147725, 2633.2758491414825, 2643.8942442302287, 2676.0767535200325, 2721.727827217282, 2731.8224315419434, 2684.838909665407, 2716.7283271672673, 2720.279126031603, 2736.767374773127, 2749.848758318292, 14914.925425372912, 15223.923880380638, 15234.619134521725, 15260.236988150658, 15262.31319590621, 7990.440669153161, 8294.543800090993, 8304.875426868603, 8305.37709671777, 8305.66777328906, 5179.766910489037, 5309.442508536626, 5490.478404551562, 5582.441755824385, 5616.66300022, 1889.5653999580036, 1939.7284380186786, 1940.5439721665398, 1970.123295133666, 1986.662267414543, 27244.182674519798, 27248.727512724818, 27445.725542744516, 27461.45077098467, 27487.587686184725, 6904.585724856524, 6965.303469653096, 6984.126984126984, 7020.368166864904, 7154.320339567733, 17679.823201768075, 17710.822891770917, 17744.556386090193, 17762.28950841952, 17794.0, 7858.410619203582, 8064.354851611857, 8112.675492980333, 8120.75637730869, 8164.428490005643, 7269.127704675473, 7442.106947166375, 7445.218252083453, 7500.024996750497, 7528.397728181732, 5168.483151684876, 5350.0, 5373.570114390917, 5373.892522149535, 5417.26866872975, 1556.8910176287552, 1563.0621627023922, 1572.4968010236614, 1587.4590733207751, 1589.666170104291, 825.2119226139023, 830.3440282177013, 855.0978717453022, 857.8027053777666, 858.5449711652834, 6873.553219040747, 6893.20728116273, 6895.103636527219, 6927.58434493932, 7091.751788687371, 714.6498215874184, 718.9209186989427, 720.0711082703255, 721.1382398034299, 726.7674344209908, 4346.5653434656915, 4364.519902810688, 4421.292593185075, 4475.910481790346, 4680.9297860532115, 21292.680609790867, 21394.35816925495, 22412.77587224107, 22439.775602243768, 22503.099876005104, 21677.132914683552, 22157.77842221557, 22306.0, 22313.21903733394, 22536.323910282717, 11439.37083460401, 11462.656120316404, 11674.416279186007, 11687.065034797195, 11708.941455292668, 7797.465823607237, 7809.843803124019, 7817.765467035998, 7837.843243134991, 7956.681732730857, 18409.737117773126, 18658.906705466386, 18931.71602425937, 19034.904825475784, 19115.522111947314, 19423.12595933158, 19434.2226310946, 19547.120379583237, 19740.573574053316, 19746.60506789885, 11225.943870280596, 11430.1998860079, 11593.304401735923, 11593.536258549564, 11601.071914246671, 14006.78989815174, 14124.2937853109, 14188.0, 14248.786268205778, 14279.71440571162, 11225.887741122811, 11228.0, 11486.138539609396, 11526.94236528812, 11648.94175529117, 11203.15976301797, 11304.208705390873, 11366.829497557377, 11433.828492572784, 11495.942520287344, 9204.815903682023, 9267.165955063807, 9506.904930950603, 9512.191463725661, 9516.95241523788, 7155.908342069667, 7310.707571697072, 7357.926420735724, 7440.776776696708, 7513.924860751541, 6906.827329316607, 6916.965415172892, 7024.789256322319, 7027.859442811217, 7134.821629459305], "value": 6632.010530254705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.557415387065, 529.8145649022845, 540.7539569495879, 545.7107732901561, 553.2834978702581, 6401.167848179736, 6468.191476065492, 6504.609723416598, 6521.347865213476, 6551.8034458966185, 6348.36516348365, 6381.425671689547, 6392.296847346788, 6403.23161220653, 6414.294427612959, 5236.266922630815, 5240.580753539727, 5250.501202385767, 5258.737063146847, 5339.893202135955, 4952.356193694833, 5081.085404627184, 5268.841934741964, 5321.866953326178, 5322.387925388591, 5032.521910418504, 5065.088284108859, 5094.821681241157, 5101.285819985205, 5111.1566591512355, 5061.44324124346, 5091.2108623163285, 5113.411957624883, 5127.589792816566, 5147.459516750762, 4505.819767209307, 4596.402467679214, 4602.240630295997, 4604.240300350438, 4611.838585649486, 6287.339829317947, 6291.779787707408, 6299.811005669837, 6304.747810087591, 6323.399277068671, 5722.97138514309, 5776.880484538344, 5820.912686309709, 5842.152887831241, 5876.794312199053, 6735.158105236846, 6740.898886516707, 6759.898601520981, 6782.8304292392595, 6800.761973330909, 5005.499450055002, 5071.315372424712, 5073.568746656539, 5076.314697515825, 5086.567641750456, 6728.529002969794, 6891.448684105309, 6961.338672826073, 7016.368526832507, 7023.192332881733, 5086.033653605877, 5098.898022039612, 5113.565346945476, 5115.104856650071, 5126.0, 5143.537081662668, 5221.530062294411, 5223.563520031946, 5252.579793616502, 5275.657082289639, 5743.483086522233, 5811.302643682785, 5832.62087964281, 5848.385919478478, 5874.325817142094, 6745.392914637706, 6767.018782276542, 6785.321467853175, 6827.078344423439, 6849.349311815369, 1769.8053214146435, 1786.7409225662207, 1805.4222648752273, 1807.8192180781816, 1819.6360727854217, 1206.5869997490347, 1241.7081985733346, 1247.9563215287603, 1260.615512268767, 1268.7906495428151, 5753.367129615739, 5763.9135412968835, 5800.6809625471005, 5808.311722056525, 5832.1834943108, 6782.152230971129, 6918.584884906922, 6923.0, 6937.965310173417, 6954.130733658293, 5754.9424505754405, 5799.333076696234, 5850.736716847752, 5851.824445266649, 5853.356130825606, 3457.27397246576, 3569.5181150544863, 3615.9819200903826, 3625.148090198801, 3663.6153203913736, 6513.804585862432, 6584.0, 6605.471562275006, 6611.743663787301, 6635.900461493082, 6903.0, 6985.860282794417, 7001.299870012958, 7004.824879378057, 7015.018617087718, 6545.9018114728315, 6550.181227346582, 6556.836079097965, 6565.540412171198, 6572.901406478906, 6701.631410272482, 6763.222229443677, 6824.624645644339, 6827.6244806536115, 6836.248012718696, 6713.462922966249, 6727.755365257443, 6800.217974932946, 6804.251532331538, 6870.931290687229, 6485.383888530582, 6530.608163510205, 6571.769988050395, 6613.371729685672, 6641.667916604054, 5043.319151914445, 5056.6207534434325, 5080.593552515864, 5110.770015349244, 5123.410807757155, 6563.1796025496815, 6579.703913323816, 6620.735170593122, 6647.734090636321, 6698.363655452724, 6449.903251451138, 6573.605583664996, 6599.901001485077, 6649.534532582867, 6696.296888826603, 6521.771722997147, 6532.41208291256, 6535.967320163369, 6561.901571476336, 6641.070250164884, 6373.5857169283845, 6413.819301437534, 6517.967410162919, 6534.444572211225, 6625.536212465081, 6589.27517973013, 6598.8350291243105, 6680.4989625779235, 6690.230623478362, 6731.865362692621, 6357.491400688026, 6375.808725738235, 6395.42441180296, 6412.210688350582, 6421.93578064232], "value": 5160.373715776774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.7300809757071, 907.5280853955943, 931.97017295888, 940.8588711693245, 945.9621615135395, 19482.610347793037, 20391.796082039175, 20394.286199982984, 20421.0, 20445.897770511165, 17751.28994840205, 17803.109844507788, 17970.730439043426, 18773.436796896116, 18984.620307593876, 979.662016604274, 992.9652462163825, 995.0845222395377, 995.7311525888006, 996.0686757881404, 957.2963871554402, 996.8155891160122, 1001.7245257554158, 1002.8746406699163, 1008.6822650864954, 1059.0838924330476, 1062.1874266186373, 1065.9307145035586, 1066.9679909602723, 1069.636323649959, 980.6077568972397, 1043.7390652336917, 1054.910332621728, 1056.0, 1056.0601065052072, 738.9408847292203, 748.5433885329944, 749.1646813802571, 749.8612756640039, 750.4446709435033, 20525.589488210302, 20734.688979665316, 20740.688889666668, 20781.896090519604, 20794.792052079436, 21681.132754689792, 22137.44656383587, 22433.32700019002, 22587.548249034928, 22622.09511619533, 15492.147931863743, 16064.27710753019, 16102.5974350641, 16197.4330898418, 16199.1090490023, 3728.720345974036, 3777.244551089793, 3795.62043795621, 3799.601041890617, 3810.618938106167, 129458.0, 130484.3475782615, 130721.0, 131045.34477327648, 132819.33590331988, 16750.329986800636, 16888.493345199662, 16947.237374318185, 17086.40197593078, 17216.397426090025, 31235.531467028013, 31489.0, 31523.842380787948, 31541.84229078886, 31730.0, 8749.300055995505, 8796.824063518694, 8815.118488151262, 8818.206361427503, 8829.911700882909, 4392.472903251631, 4434.977825110918, 4474.463064432224, 4482.9913269514755, 4505.594496495331, 5483.862903427446, 5542.944570554324, 5571.916421253684, 5572.693501857356, 5582.441755824385, 919.9862002069974, 937.9437233765996, 950.9857352139724, 955.3599088610648, 958.3531116496337, 692.8233300508338, 710.5167439797939, 714.0538786108427, 730.82825535999, 732.2531018361242, 11992.763762843448, 12309.753804923852, 12783.360831958365, 13067.607971760863, 13486.12340197884, 709.2836235402177, 711.1714852197132, 714.1501613080418, 721.487743701967, 729.2270193594807, 5521.779128834802, 5583.776648933997, 5624.465675760796, 5671.546276297886, 5674.943250567524, 117636.0, 120464.0, 122110.0, 122249.0, 123767.0, 104665.0, 105750.4712476448, 106746.0, 106988.72045118109, 109665.0, 91451.54274228586, 92210.07789922149, 93354.53322733479, 94175.0, 94842.0, 10214.489275536342, 10377.688669339932, 10450.738731531772, 10553.577856885639, 10568.154547636324, 43638.34542481802, 44742.55257447384, 45363.77318113388, 46081.0, 46757.766211170085, 55572.72213638906, 56898.43101568931, 57048.429515705975, 57685.42314576801, 58296.4170358291, 15825.129617871127, 16148.67702645964, 16162.111083890028, 16336.754948676016, 16383.426580069641, 16672.666546669243, 16810.0, 16859.409920652717, 16963.321467141177, 16974.49076527706, 16883.155842207594, 16943.830561694227, 16976.490705278862, 17037.38144876235, 17149.142542873054, 15764.842351576795, 15784.842151578796, 16029.278682459084, 16069.11619860872, 16270.51188464348, 15449.922750386626, 15455.459058932884, 15534.067955922681, 15580.0, 15682.76475852886, 11776.234544754563, 11926.761464770829, 11934.164608477324, 11964.102692297938, 12124.787521247805, 11907.642770716546, 12003.459844306852, 12081.154319197572, 12156.209846359958, 12274.938625306817], "value": 8998.997818324948, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 106.0, 106.0, 107.0, 108.0, 106.0, 107.0, 108.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 116.0, 119.0, 117.0, 121.0, 116.0, 149.0, 119.0, 117.0, 139.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 162.0, 163.0, 163.0, 162.0, 167.0, 167.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 74.0, 75.0, 73.0, 74.0, 75.0, 75.0, 75.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 79.0, 78.0, 79.0, 78.0, 78.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 111.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 96.0, 100.0, 96.0, 96.0, 96.0, 94.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 39.0, 39.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 82.0, 72.0, 74.0, 72.0, 73.0, 71.0, 74.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 121.0, 110.0, 107.0, 121.0, 109.0, 117.0, 109.0, 121.0], "value": 113.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 163.0, 167.0, 178.0, 166.0, 166.0, 165.0, 163.0, 177.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 64.0, 64.0, 67.0, 64.0, 63.0, 67.0, 67.0, 70.0], "value": 66.2, "unit": "score"}]}]} 17:04:06 INFO - Return code: 0 17:04:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:04:06 INFO - # TBPL SUCCESS # 17:04:06 INFO - Running post-action listener: _package_coverage_data 17:04:06 INFO - Running post-action listener: _resource_record_post_action 17:04:06 INFO - [mozharness: 2017-09-28 00:04:06.952227Z] Finished run-tests step (success) 17:04:06 INFO - Running post-run listener: _resource_record_post_run 17:04:07 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 155648; Write bytes: 334311424; Read time: 64; Write time: 173488 17:04:07 INFO - TinderboxPrint: CPU usage
13.1% 17:04:07 INFO - TinderboxPrint: I/O read bytes / time
155,648 / 64 17:04:07 INFO - TinderboxPrint: I/O write bytes / time
334,311,424 / 173,488 17:04:07 INFO - TinderboxPrint: CPU idle
8,229.4 (86.9%) 17:04:07 INFO - TinderboxPrint: CPU user
1,193.5 (12.6%) 17:04:07 INFO - TinderboxPrint: Swap in / out
0 / 0 17:04:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10080256; Read time: 0; Write time: 716 17:04:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:04:07 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 147456; Write bytes: 324231168; Read time: 44; Write time: 172772 17:04:07 INFO - Running post-run listener: _upload_blobber_files 17:04:07 INFO - Blob upload gear active. 17:04:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:04:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:09 INFO - (blobuploader) - INFO - Done attempting. 17:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:10 INFO - (blobuploader) - INFO - Done attempting. 17:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:16 INFO - (blobuploader) - INFO - Done attempting. 17:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:04:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:17 INFO - (blobuploader) - INFO - Done attempting. 17:04:17 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:17 INFO - Return code: 0 17:04:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35dce90a7a067cf01bc29a51a4e83e3519ea171e363ca7fe9e23b21724743ba733bf2092e807feed5c765b662c4b5448acc11c71c265eba1904ebfe2888ca304", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4dfa4ab098e74c1a4ae141b03adb771fd28f4a4353ab7b5798f1b202892d2f7a4e2766cdc8301cca0c359c13e6fbf6db7b706d64784f6e092b9ce7da9aa0d80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da723ad5f1296e89e910ae138c169eea92d60758e17db37dd761c504716801ad5b28bc140fc8c77883fd5c10a8ab82abb4e2ce36531dc54ba1e8f9ca771a459e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36a98278ff026011e716ba5b837476361de8b62fff4b49cd8b2edcb84a0b0bc92d3de9c2dc7ae17267aca014a7d85dbb1c5a85f264876394f56220e3e50d19e5"} 17:04:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:17 INFO - Contents: 17:04:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35dce90a7a067cf01bc29a51a4e83e3519ea171e363ca7fe9e23b21724743ba733bf2092e807feed5c765b662c4b5448acc11c71c265eba1904ebfe2888ca304", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4dfa4ab098e74c1a4ae141b03adb771fd28f4a4353ab7b5798f1b202892d2f7a4e2766cdc8301cca0c359c13e6fbf6db7b706d64784f6e092b9ce7da9aa0d80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da723ad5f1296e89e910ae138c169eea92d60758e17db37dd761c504716801ad5b28bc140fc8c77883fd5c10a8ab82abb4e2ce36531dc54ba1e8f9ca771a459e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36a98278ff026011e716ba5b837476361de8b62fff4b49cd8b2edcb84a0b0bc92d3de9c2dc7ae17267aca014a7d85dbb1c5a85f264876394f56220e3e50d19e5"} 17:04:17 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:17 INFO - Copying logs to upload dir... 17:04:17 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.465134 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-27 17:04:17.976646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 17:04:17.980877) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412 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/35dce90a7a067cf01bc29a51a4e83e3519ea171e363ca7fe9e23b21724743ba733bf2092e807feed5c765b662c4b5448acc11c71c265eba1904ebfe2888ca304", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4dfa4ab098e74c1a4ae141b03adb771fd28f4a4353ab7b5798f1b202892d2f7a4e2766cdc8301cca0c359c13e6fbf6db7b706d64784f6e092b9ce7da9aa0d80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da723ad5f1296e89e910ae138c169eea92d60758e17db37dd761c504716801ad5b28bc140fc8c77883fd5c10a8ab82abb4e2ce36531dc54ba1e8f9ca771a459e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36a98278ff026011e716ba5b837476361de8b62fff4b49cd8b2edcb84a0b0bc92d3de9c2dc7ae17267aca014a7d85dbb1c5a85f264876394f56220e3e50d19e5"} build_url:https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/dp8k4SKiS8qEBmLBTOvhFQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35dce90a7a067cf01bc29a51a4e83e3519ea171e363ca7fe9e23b21724743ba733bf2092e807feed5c765b662c4b5448acc11c71c265eba1904ebfe2888ca304", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4dfa4ab098e74c1a4ae141b03adb771fd28f4a4353ab7b5798f1b202892d2f7a4e2766cdc8301cca0c359c13e6fbf6db7b706d64784f6e092b9ce7da9aa0d80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da723ad5f1296e89e910ae138c169eea92d60758e17db37dd761c504716801ad5b28bc140fc8c77883fd5c10a8ab82abb4e2ce36531dc54ba1e8f9ca771a459e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36a98278ff026011e716ba5b837476361de8b62fff4b49cd8b2edcb84a0b0bc92d3de9c2dc7ae17267aca014a7d85dbb1c5a85f264876394f56220e3e50d19e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 17:04:18.012943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:04:18.013324) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506555813.263093-1275593412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:04:18.097507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 17:04:18.097832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 17:04:18.098146) ========= ========= Total master_lag: 0.26 =========