builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-035 starttime: 1506703165.59 results: success (0) revision: 935eca685536793ab7df8bfc9fb52d70128f7756 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.591108) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.591518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.591786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.655902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.656338) ========= 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=ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 09:39:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.9M=0s 2017-09-29 09:39:25 (49.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129970 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.813380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.813685) ========= 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=ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021294 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.872421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:25.872728) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 935eca685536793ab7df8bfc9fb52d70128f7756 --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 935eca685536793ab7df8bfc9fb52d70128f7756 --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=ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 09:39:25,925 truncating revision to first 12 chars 2017-09-29 09:39:25,926 Setting DEBUG logging. 2017-09-29 09:39:25,926 attempt 1/10 2017-09-29 09:39:25,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/935eca685536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 09:39:26,181 unpacking tar archive at: mozilla-central-935eca685536/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533134 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:26.435044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:26.435443) ========= script_repo_revision: 935eca685536793ab7df8bfc9fb52d70128f7756 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:26.435880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:26.436149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 09:39:26.465400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 09:39:26.465749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:39:26 INFO - MultiFileLogger online at 20170929 09:39:26 in /builds/slave/test 09:39:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:39:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:26 INFO - {'append_to_log': False, 09:39:26 INFO - 'base_work_dir': '/builds/slave/test', 09:39:26 INFO - 'blob_upload_branch': 'Firefox', 09:39:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:26 INFO - 'branch': 'Firefox', 09:39:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:26 INFO - 'code_coverage': False, 09:39:26 INFO - 'config_files': ('talos/linux_config.py',), 09:39:26 INFO - 'default_actions': ('clobber', 09:39:26 INFO - 'read-buildbot-config', 09:39:26 INFO - 'download-and-extract', 09:39:26 INFO - 'populate-webroot', 09:39:26 INFO - 'create-virtualenv', 09:39:26 INFO - 'install', 09:39:26 INFO - 'setup-mitmproxy', 09:39:26 INFO - 'run-tests'), 09:39:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:26 INFO - 'disable_ccov_upload': False, 09:39:26 INFO - 'disable_stylo': False, 09:39:26 INFO - 'download_minidump_stackwalk': True, 09:39:26 INFO - 'download_symbols': 'ondemand', 09:39:26 INFO - 'enable_stylo': False, 09:39:26 INFO - 'enable_webrender': False, 09:39:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:39:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:26 INFO - 'gecko_profile': False, 09:39:26 INFO - 'gecko_profile_interval': 0, 09:39:26 INFO - 'installer_path': 'installer.exe', 09:39:26 INFO - 'log_level': 'info', 09:39:26 INFO - 'log_name': 'talos', 09:39:26 INFO - 'log_to_console': True, 09:39:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:39:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:39:26 INFO - 'opt_config_files': (), 09:39:26 INFO - 'pip_index': False, 09:39:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 09:39:26 INFO - 'system_bits': '32', 09:39:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:26 INFO - 'title': 'talos-linux64-ix-035', 09:39:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:26 INFO - 'use_talos_json': True, 09:39:26 INFO - 'verify': 'False', 09:39:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:26 INFO - 'work_dir': 'build'} 09:39:26 INFO - [mozharness: 2017-09-29 16:39:26.655977Z] Running clobber step. 09:39:26 INFO - Running pre-action listener: _resource_record_pre_action 09:39:26 INFO - Running main action method: clobber 09:39:26 INFO - rmtree: /builds/slave/test/build 09:39:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:27 INFO - Running post-action listener: _resource_record_post_action 09:39:27 INFO - [mozharness: 2017-09-29 16:39:27.646630Z] Finished clobber step (success) 09:39:27 INFO - [mozharness: 2017-09-29 16:39:27.646727Z] Running read-buildbot-config step. 09:39:27 INFO - Running pre-action listener: _resource_record_pre_action 09:39:27 INFO - Running main action method: read_buildbot_config 09:39:27 INFO - Using buildbot properties: 09:39:27 INFO - { 09:39:27 INFO - "project": "", 09:39:27 INFO - "product": "firefox", 09:39:27 INFO - "who": "ryanvm@gmail.com", 09:39:27 INFO - "installer_path": "public/build/target.tar.bz2", 09:39:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 09:39:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:39:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 09:39:27 INFO - "stage_platform": "linux64-pgo", 09:39:27 INFO - "basedir": "/builds/slave/test", 09:39:27 INFO - "buildnumber": 75, 09:39:27 INFO - "platform": "ubuntu64_hw", 09:39:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:39:27 INFO - "slavebuilddir": "test", 09:39:27 INFO - "taskId": "dLv5iHY0TSezV60DsArJmA", 09:39:27 INFO - "branch": "mozilla-central", 09:39:27 INFO - "script_repo_revision": "production", 09:39:27 INFO - "revision": "935eca685536793ab7df8bfc9fb52d70128f7756", 09:39:27 INFO - "slavename": "talos-linux64-ix-035", 09:39:27 INFO - "repo_path": "mozilla-central" 09:39:27 INFO - } 09:39:27 INFO - Finding installer, test and symbols from parent task. 09:39:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLv5iHY0TSezV60DsArJmA'}, attempt #1 09:39:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLv5iHY0TSezV60DsArJmA'}, attempt #1 09:39:28 INFO - Task dependencies: KTzW7DnASLiFmbwUj_DZhg 09:39:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg'}, attempt #1 09:39:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2 09:39:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.test_packages.json 09:39:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.crashreporter-symbols.zip 09:39:29 INFO - Running post-action listener: _resource_record_post_action 09:39:29 INFO - [mozharness: 2017-09-29 16:39:29.083932Z] Finished read-buildbot-config step (success) 09:39:29 INFO - [mozharness: 2017-09-29 16:39:29.084150Z] Running download-and-extract step. 09:39:29 INFO - Running pre-action listener: _resource_record_pre_action 09:39:29 INFO - Running main action method: download_and_extract 09:39:29 INFO - mkdir: /builds/slave/test/build/tests 09:39:29 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')]} 09:39:29 INFO - trying https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.test_packages.json 09:39:29 INFO - Downloading https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:39:29 INFO - Downloaded 989 bytes. 09:39:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:39:29 INFO - Using the following test package requirements: 09:39:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:39:29 INFO - u'common': [u'target.common.tests.zip'], 09:39:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:39:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:39:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:39:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:39:29 INFO - u'mozbase': [u'target.common.tests.zip'], 09:39:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:39:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:39:29 INFO - u'web-platform': [u'target.common.tests.zip', 09:39:29 INFO - u'target.web-platform.tests.tar.gz'], 09:39:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:39:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:39:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.common.tests.zip 09:39:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:39:29 INFO - Fetch https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.common.tests.zip into memory 09:39:32 INFO - Content-Length response header: 55921943 09:39:32 INFO - Bytes received: 55921943 09:39:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.talos.tests.zip 09:39:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:39:43 INFO - Fetch https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.talos.tests.zip into memory 09:39:44 INFO - Content-Length response header: 14521355 09:39:44 INFO - Bytes received: 14521355 09:39:44 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')]} 09:39:44 INFO - trying https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2 09:39:44 INFO - Downloading https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:39:47 INFO - Downloaded 62352793 bytes. 09:39:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2 09:39:47 INFO - mkdir: /builds/slave/test/properties 09:39:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:47 INFO - Contents: 09:39:47 INFO - build_url:https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2 09:39:47 INFO - Running post-action listener: _resource_record_post_action 09:39:47 INFO - Running post-action listener: find_tests_for_verification 09:39:47 INFO - Running post-action listener: set_extra_try_arguments 09:39:47 INFO - [mozharness: 2017-09-29 16:39:47.501632Z] Finished download-and-extract step (success) 09:39:47 INFO - [mozharness: 2017-09-29 16:39:47.501732Z] Running populate-webroot step. 09:39:47 INFO - Running pre-action listener: _resource_record_pre_action 09:39:47 INFO - Running main action method: populate_webroot 09:39:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['tresize', 09:39:47 INFO - 'tcanvasmark']}, 09:39:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['dromaeo_css', 09:39:47 INFO - 'kraken']}, 09:39:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'tests': ['damp', 'tps']}, 09:39:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['damp', 'tps']}, 09:39:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['dromaeo_dom']}, 09:39:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:39:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['basic_compositor_video', 09:39:47 INFO - 'glvideo']}, 09:39:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:39:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['ts_paint_webext', 09:39:47 INFO - 'tp5o_webext']}, 09:39:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:47 INFO - 'ts_paint', 09:39:47 INFO - 'tpaint', 09:39:47 INFO - 'sessionrestore', 09:39:47 INFO - 'sessionrestore_many_windows', 09:39:47 INFO - 'sessionrestore_no_auto_restore', 09:39:47 INFO - 'tabpaint', 09:39:47 INFO - 'cpstartup']}, 09:39:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['a11yr', 09:39:47 INFO - 'ts_paint', 09:39:47 INFO - 'tpaint', 09:39:47 INFO - 'sessionrestore', 09:39:47 INFO - 'sessionrestore_many_windows', 09:39:47 INFO - 'sessionrestore_no_auto_restore', 09:39:47 INFO - 'tabpaint', 09:39:47 INFO - 'cpstartup']}, 09:39:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 09:39:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:39:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['perf_reftest_singletons']}, 09:39:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['perf_reftest']}, 09:39:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:47 INFO - 'tsvgr_opacity', 09:39:47 INFO - 'tart', 09:39:47 INFO - 'tscrollx', 09:39:47 INFO - 'tsvg_static']}, 09:39:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['tsvgx', 09:39:47 INFO - 'tsvgr_opacity', 09:39:47 INFO - 'tart', 09:39:47 INFO - 'tscrollx', 09:39:47 INFO - 'tsvg_static']}, 09:39:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:39:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'talos_options': ['--disable-stylo'], 09:39:47 INFO - 'tests': ['tp5o']}, 09:39:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:39:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 09:39:47 INFO - 'talos_options': ['--mitmproxy', 09:39:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:39:47 INFO - '--firstNonBlankPaint'], 09:39:47 INFO - 'tests': ['tp6_google', 09:39:47 INFO - 'tp6_youtube', 09:39:47 INFO - 'tp6_amazon', 09:39:47 INFO - 'tp6_facebook']}, 09:39:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:39:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 09:39:47 INFO - 'talos_options': ['--disable-stylo', 09:39:47 INFO - '--mitmproxy', 09:39:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:39:47 INFO - '--firstNonBlankPaint'], 09:39:47 INFO - 'tests': ['tp6_google', 09:39:47 INFO - 'tp6_youtube', 09:39:47 INFO - 'tp6_amazon', 09:39:47 INFO - 'tp6_facebook']}, 09:39:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:39:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 09:39:47 INFO - 'talos_options': ['--stylo-threads=1', 09:39:47 INFO - '--mitmproxy', 09:39:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:39:47 INFO - '--firstNonBlankPaint'], 09:39:47 INFO - 'tests': ['tp6_google', 09:39:47 INFO - 'tp6_youtube', 09:39:47 INFO - 'tp6_amazon', 09:39:47 INFO - 'tp6_facebook']}, 09:39:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'talos_options': ['--xperf_path', 09:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:47 INFO - 'tests': ['tp5n']}, 09:39:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:39:47 INFO - 'talos_options': ['--disable-stylo', 09:39:47 INFO - '--xperf_path', 09:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:47 INFO - 'tests': ['tp5n']}}} 09:39:47 INFO - Running post-action listener: _resource_record_post_action 09:39:47 INFO - [mozharness: 2017-09-29 16:39:47.521528Z] Finished populate-webroot step (success) 09:39:47 INFO - [mozharness: 2017-09-29 16:39:47.521618Z] Running create-virtualenv step. 09:39:47 INFO - Running pre-action listener: _resource_record_pre_action 09:39:47 INFO - Running main action method: create_virtualenv 09:39:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:39:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:39:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:39:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:48 INFO - Installing pip...............done. 09:39:48 INFO - Return code: 0 09:39:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:39:48 INFO - Reading from file tmpfile_stdout 09:39:48 INFO - Output received: 09:39:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:39:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:48 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')]} 09:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:48 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')]} 09:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:48 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:48 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 09:39:48 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 09:39:48 INFO - Using env: {'DISPLAY': ':0', 09:39:48 INFO - 'HOME': '/home/cltbld', 09:39:48 INFO - 'LANG': 'en_US.UTF-8', 09:39:48 INFO - 'LANGUAGE': 'en_US:en', 09:39:48 INFO - 'LOGNAME': 'cltbld', 09:39:48 INFO - 'MAIL': '/var/mail/cltbld', 09:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:48 INFO - 'MOZ_NO_REMOTE': '1', 09:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:48 INFO - 'NO_EM_RESTART': '1', 09:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:48 INFO - 'PWD': '/builds/slave/test', 09:39:48 INFO - 'SHELL': '/bin/bash', 09:39:48 INFO - 'SHLVL': '1', 09:39:48 INFO - 'TERM': 'linux', 09:39:48 INFO - 'TMOUT': '86400', 09:39:48 INFO - 'USER': 'cltbld', 09:39:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:48 INFO - '_': '/tools/buildbot/bin/python'} 09:39:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:39:49 INFO - Downloading/unpacking pip>=1.5 09:39:49 INFO - Running setup.py egg_info for package pip 09:39:49 INFO - warning: no files found matching 'pip/cacert.pem' 09:39:49 INFO - warning: no files found matching '*.html' under directory 'docs' 09:39:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:39:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:39:49 INFO - Installing collected packages: pip 09:39:49 INFO - Found existing installation: pip 1.1 09:39:49 INFO - Uninstalling pip: 09:39:49 INFO - Successfully uninstalled pip 09:39:49 INFO - Running setup.py install for pip 09:39:49 INFO - warning: no files found matching 'pip/cacert.pem' 09:39:49 INFO - warning: no files found matching '*.html' under directory 'docs' 09:39:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:39:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:39:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Successfully installed pip 09:39:49 INFO - Cleaning up... 09:39:49 INFO - Return code: 0 09:39:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:49 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:49 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 09:39:49 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 09:39:49 INFO - Using env: {'DISPLAY': ':0', 09:39:49 INFO - 'HOME': '/home/cltbld', 09:39:49 INFO - 'LANG': 'en_US.UTF-8', 09:39:49 INFO - 'LANGUAGE': 'en_US:en', 09:39:49 INFO - 'LOGNAME': 'cltbld', 09:39:49 INFO - 'MAIL': '/var/mail/cltbld', 09:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:49 INFO - 'MOZ_NO_REMOTE': '1', 09:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:49 INFO - 'NO_EM_RESTART': '1', 09:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:49 INFO - 'PWD': '/builds/slave/test', 09:39:49 INFO - 'SHELL': '/bin/bash', 09:39:49 INFO - 'SHLVL': '1', 09:39:49 INFO - 'TERM': 'linux', 09:39:49 INFO - 'TMOUT': '86400', 09:39:49 INFO - 'USER': 'cltbld', 09:39:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:49 INFO - '_': '/tools/buildbot/bin/python'} 09:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:49 INFO - Downloading/unpacking psutil>=3.1.1 09:39:49 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 09:39:49 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 09:39:49 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 09:39:49 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 09:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:51 INFO - Installing collected packages: psutil 09:39:51 INFO - Running setup.py install for psutil 09:39:51 INFO - building 'psutil._psutil_linux' extension 09:39:51 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 09:39:51 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 09:39:51 INFO - building 'psutil._psutil_posix' extension 09:39:51 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 09:39:51 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 09:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:51 INFO - Successfully installed psutil 09:39:51 INFO - Cleaning up... 09:39:53 INFO - Return code: 0 09:39:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:53 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')]} 09:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:53 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')]} 09:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:53 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:53 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 09:39:53 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 09:39:53 INFO - Using env: {'DISPLAY': ':0', 09:39:53 INFO - 'HOME': '/home/cltbld', 09:39:53 INFO - 'LANG': 'en_US.UTF-8', 09:39:53 INFO - 'LANGUAGE': 'en_US:en', 09:39:53 INFO - 'LOGNAME': 'cltbld', 09:39:53 INFO - 'MAIL': '/var/mail/cltbld', 09:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:53 INFO - 'MOZ_NO_REMOTE': '1', 09:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:53 INFO - 'NO_EM_RESTART': '1', 09:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:53 INFO - 'PWD': '/builds/slave/test', 09:39:53 INFO - 'SHELL': '/bin/bash', 09:39:53 INFO - 'SHLVL': '1', 09:39:53 INFO - 'TERM': 'linux', 09:39:53 INFO - 'TMOUT': '86400', 09:39:53 INFO - 'USER': 'cltbld', 09:39:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:53 INFO - '_': '/tools/buildbot/bin/python'} 09:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:54 INFO - Installing collected packages: mozsystemmonitor 09:39:54 INFO - Running setup.py install for mozsystemmonitor 09:39:54 INFO - Successfully installed mozsystemmonitor 09:39:54 INFO - Cleaning up... 09:39:54 INFO - Return code: 0 09:39:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:54 INFO - Using env: {'DISPLAY': ':0', 09:39:54 INFO - 'HOME': '/home/cltbld', 09:39:54 INFO - 'LANG': 'en_US.UTF-8', 09:39:54 INFO - 'LANGUAGE': 'en_US:en', 09:39:54 INFO - 'LOGNAME': 'cltbld', 09:39:54 INFO - 'MAIL': '/var/mail/cltbld', 09:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:54 INFO - 'MOZ_NO_REMOTE': '1', 09:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:54 INFO - 'NO_EM_RESTART': '1', 09:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:54 INFO - 'PWD': '/builds/slave/test', 09:39:54 INFO - 'SHELL': '/bin/bash', 09:39:54 INFO - 'SHLVL': '1', 09:39:54 INFO - 'TERM': 'linux', 09:39:54 INFO - 'TMOUT': '86400', 09:39:54 INFO - 'USER': 'cltbld', 09:39:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:54 INFO - '_': '/tools/buildbot/bin/python'} 09:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:56 INFO - warning: no files found matching '*.txt' 09:39:56 INFO - no previously-included directories found matching 'build' 09:39:56 INFO - no previously-included directories found matching 'dist' 09:39:56 INFO - no previously-included directories found matching '.git*' 09:39:56 INFO - Installing collected packages: jsonschema, functools32 09:39:56 INFO - Running setup.py install for functools32 09:39:56 INFO - warning: no files found matching '*.txt' 09:39:56 INFO - no previously-included directories found matching 'build' 09:39:56 INFO - no previously-included directories found matching 'dist' 09:39:56 INFO - no previously-included directories found matching '.git*' 09:39:56 INFO - Successfully installed jsonschema functools32 09:39:56 INFO - Cleaning up... 09:39:56 INFO - Return code: 0 09:39:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:39:56 INFO - Using env: {'DISPLAY': ':0', 09:39:56 INFO - 'HOME': '/home/cltbld', 09:39:56 INFO - 'LANG': 'en_US.UTF-8', 09:39:56 INFO - 'LANGUAGE': 'en_US:en', 09:39:56 INFO - 'LOGNAME': 'cltbld', 09:39:56 INFO - 'MAIL': '/var/mail/cltbld', 09:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:56 INFO - 'MOZ_NO_REMOTE': '1', 09:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:56 INFO - 'NO_EM_RESTART': '1', 09:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:56 INFO - 'PWD': '/builds/slave/test', 09:39:56 INFO - 'SHELL': '/bin/bash', 09:39:56 INFO - 'SHLVL': '1', 09:39:56 INFO - 'TERM': 'linux', 09:39:56 INFO - 'TMOUT': '86400', 09:39:56 INFO - 'USER': 'cltbld', 09:39:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:56 INFO - '_': '/tools/buildbot/bin/python'} 09:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:56 INFO - Cleaning up... 09:39:56 INFO - Return code: 0 09:39:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:39:56 INFO - Using env: {'DISPLAY': ':0', 09:39:56 INFO - 'HOME': '/home/cltbld', 09:39:56 INFO - 'LANG': 'en_US.UTF-8', 09:39:56 INFO - 'LANGUAGE': 'en_US:en', 09:39:56 INFO - 'LOGNAME': 'cltbld', 09:39:56 INFO - 'MAIL': '/var/mail/cltbld', 09:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:56 INFO - 'MOZ_NO_REMOTE': '1', 09:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:56 INFO - 'NO_EM_RESTART': '1', 09:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:56 INFO - 'PWD': '/builds/slave/test', 09:39:56 INFO - 'SHELL': '/bin/bash', 09:39:56 INFO - 'SHLVL': '1', 09:39:56 INFO - 'TERM': 'linux', 09:39:56 INFO - 'TMOUT': '86400', 09:39:56 INFO - 'USER': 'cltbld', 09:39:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:56 INFO - '_': '/tools/buildbot/bin/python'} 09:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:58 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 09:39:58 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 09:39:58 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 09:39:58 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 09:39:58 INFO - Downloading docopt-0.6.1.tar.gz 09:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:58 INFO - Running setup.py install for blobuploader 09:39:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:58 INFO - Running setup.py install for requests 09:39:58 INFO - Running setup.py install for docopt 09:39:58 INFO - Successfully installed blobuploader requests docopt 09:39:58 INFO - Cleaning up... 09:39:58 INFO - Return code: 0 09:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:58 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')]} 09:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:58 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')]} 09:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:59 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:39:59 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 09:39:59 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 09:39:59 INFO - Using env: {'DISPLAY': ':0', 09:39:59 INFO - 'HOME': '/home/cltbld', 09:39:59 INFO - 'LANG': 'en_US.UTF-8', 09:39:59 INFO - 'LANGUAGE': 'en_US:en', 09:39:59 INFO - 'LOGNAME': 'cltbld', 09:39:59 INFO - 'MAIL': '/var/mail/cltbld', 09:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:59 INFO - 'MOZ_NO_REMOTE': '1', 09:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:59 INFO - 'NO_EM_RESTART': '1', 09:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:59 INFO - 'PWD': '/builds/slave/test', 09:39:59 INFO - 'SHELL': '/bin/bash', 09:39:59 INFO - 'SHLVL': '1', 09:39:59 INFO - 'TERM': 'linux', 09:39:59 INFO - 'TMOUT': '86400', 09:39:59 INFO - 'USER': 'cltbld', 09:39:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:59 INFO - '_': '/tools/buildbot/bin/python'} 09:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:59 INFO - Running setup.py (path:/tmp/pip-neEjlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:59 INFO - Running setup.py (path:/tmp/pip-mP9mCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:59 INFO - Running setup.py (path:/tmp/pip-0jtUwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:59 INFO - Running setup.py (path:/tmp/pip-k6OmrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:59 INFO - Running setup.py (path:/tmp/pip-6cYeai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:59 INFO - Running setup.py (path:/tmp/pip-x_MZDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:59 INFO - Running setup.py (path:/tmp/pip-Nz5E8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:59 INFO - Running setup.py (path:/tmp/pip-TCiUTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:59 INFO - Running setup.py (path:/tmp/pip-foI3nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:59 INFO - Running setup.py (path:/tmp/pip-1viBpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:59 INFO - Running setup.py (path:/tmp/pip-HxmOy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:59 INFO - Running setup.py (path:/tmp/pip-aiCMmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:00 INFO - Running setup.py (path:/tmp/pip-9Z0T3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:00 INFO - Running setup.py (path:/tmp/pip-CO9E64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:00 INFO - Running setup.py (path:/tmp/pip-LrqVvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:00 INFO - Running setup.py (path:/tmp/pip-YeMEnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:00 INFO - Running setup.py (path:/tmp/pip-UqqRVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:00 INFO - Running setup.py install for manifestparser 09:40:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:00 INFO - Running setup.py install for mozcrash 09:40:00 INFO - Running setup.py install for mozdebug 09:40:00 INFO - Running setup.py install for mozdevice 09:40:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:00 INFO - Running setup.py install for mozfile 09:40:00 INFO - Running setup.py install for mozhttpd 09:40:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:00 INFO - Running setup.py install for mozinfo 09:40:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Running setup.py install for mozInstall 09:40:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Running setup.py install for mozleak 09:40:01 INFO - Running setup.py install for mozlog 09:40:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Running setup.py install for moznetwork 09:40:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Running setup.py install for mozprocess 09:40:01 INFO - Running setup.py install for mozprofile 09:40:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Running setup.py install for mozrunner 09:40:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:01 INFO - Running setup.py install for mozscreenshot 09:40:01 INFO - Running setup.py install for moztest 09:40:02 INFO - Running setup.py install for mozversion 09:40:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:02 INFO - Cleaning up... 09:40:02 INFO - Return code: 0 09:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:02 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:40:02 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 09:40:02 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 09:40:02 INFO - Using env: {'DISPLAY': ':0', 09:40:02 INFO - 'HOME': '/home/cltbld', 09:40:02 INFO - 'LANG': 'en_US.UTF-8', 09:40:02 INFO - 'LANGUAGE': 'en_US:en', 09:40:02 INFO - 'LOGNAME': 'cltbld', 09:40:02 INFO - 'MAIL': '/var/mail/cltbld', 09:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:02 INFO - 'MOZ_NO_REMOTE': '1', 09:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:02 INFO - 'NO_EM_RESTART': '1', 09:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:02 INFO - 'PWD': '/builds/slave/test', 09:40:02 INFO - 'SHELL': '/bin/bash', 09:40:02 INFO - 'SHLVL': '1', 09:40:02 INFO - 'TERM': 'linux', 09:40:02 INFO - 'TMOUT': '86400', 09:40:02 INFO - 'USER': 'cltbld', 09:40:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:02 INFO - '_': '/tools/buildbot/bin/python'} 09:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:02 INFO - Running setup.py (path:/tmp/pip-J8DiSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:02 INFO - Running setup.py (path:/tmp/pip-0nq6Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:02 INFO - Running setup.py (path:/tmp/pip-u9hp6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:02 INFO - Running setup.py (path:/tmp/pip-wUf50n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:02 INFO - Running setup.py (path:/tmp/pip-iiiy0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:02 INFO - Running setup.py (path:/tmp/pip-pVupq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:02 INFO - Running setup.py (path:/tmp/pip-kvYnnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:02 INFO - Running setup.py (path:/tmp/pip-F3fb52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:02 INFO - Running setup.py (path:/tmp/pip-Oi3KPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:02 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)) 09:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:03 INFO - Running setup.py (path:/tmp/pip-xydXaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:03 INFO - Running setup.py (path:/tmp/pip-wP2vmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:03 INFO - Running setup.py (path:/tmp/pip-gnSgTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:03 INFO - Running setup.py (path:/tmp/pip-lhKR55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:03 INFO - Running setup.py (path:/tmp/pip-ZBJj7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:03 INFO - Running setup.py (path:/tmp/pip-_nFeDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:03 INFO - Running setup.py (path:/tmp/pip-Gbef4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:03 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)) 09:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:03 INFO - Running setup.py (path:/tmp/pip-EFPD15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40: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 09:40: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 09:40: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 09:40: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 09:40:04 INFO - Downloading blessings-1.6.tar.gz 09:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:04 INFO - Installing collected packages: blessings 09:40:04 INFO - Running setup.py install for blessings 09:40:04 INFO - Successfully installed blessings 09:40:04 INFO - Cleaning up... 09:40:04 INFO - Return code: 0 09:40:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:05 INFO - Reading from file tmpfile_stdout 09:40:05 INFO - Current package versions: 09:40:05 INFO - argparse == 1.2.1 09:40:05 INFO - blessings == 1.6 09:40:05 INFO - blobuploader == 1.2.4 09:40:05 INFO - docopt == 0.6.1 09:40:05 INFO - functools32 == 3.2.3-2 09:40:05 INFO - jsonschema == 2.5.1 09:40:05 INFO - manifestparser == 1.1 09:40:05 INFO - mozInstall == 1.13 09:40:05 INFO - mozcrash == 1.0 09:40:05 INFO - mozdebug == 0.1 09:40:05 INFO - mozdevice == 0.51 09:40:05 INFO - mozfile == 1.2 09:40:05 INFO - mozhttpd == 0.7 09:40:05 INFO - mozinfo == 0.10 09:40:05 INFO - mozleak == 0.1 09:40:05 INFO - mozlog == 3.5 09:40:05 INFO - moznetwork == 0.27 09:40:05 INFO - mozprocess == 0.25 09:40:05 INFO - mozprofile == 0.28 09:40:05 INFO - mozrunner == 6.13 09:40:05 INFO - mozscreenshot == 0.1 09:40:05 INFO - mozsystemmonitor == 0.3 09:40:05 INFO - moztest == 0.8 09:40:05 INFO - mozversion == 1.4 09:40:05 INFO - psutil == 3.1.1 09:40:05 INFO - requests == 1.2.3 09:40:05 INFO - wsgiref == 0.1.2 09:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:05 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 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:40:05 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 09:40:05 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 09:40:05 INFO - Using env: {'DISPLAY': ':0', 09:40:05 INFO - 'HOME': '/home/cltbld', 09:40:05 INFO - 'LANG': 'en_US.UTF-8', 09:40:05 INFO - 'LANGUAGE': 'en_US:en', 09:40:05 INFO - 'LOGNAME': 'cltbld', 09:40:05 INFO - 'MAIL': '/var/mail/cltbld', 09:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:05 INFO - 'MOZ_NO_REMOTE': '1', 09:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:05 INFO - 'NO_EM_RESTART': '1', 09:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:05 INFO - 'PWD': '/builds/slave/test', 09:40:05 INFO - 'SHELL': '/bin/bash', 09:40:05 INFO - 'SHLVL': '1', 09:40:05 INFO - 'TERM': 'linux', 09:40:05 INFO - 'TMOUT': '86400', 09:40:05 INFO - 'USER': 'cltbld', 09:40:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:05 INFO - '_': '/tools/buildbot/bin/python'} 09:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 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)) 09:40:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:40: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 09:40: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 09:40: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 09:40: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 09:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:40:06 INFO - Installing collected packages: simplejson 09:40:06 INFO - Running setup.py install for simplejson 09:40:06 INFO - building 'simplejson._speedups' extension 09:40:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 09:40:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 09:40:07 INFO - Successfully installed simplejson 09:40:07 INFO - Cleaning up... 09:40:07 INFO - Return code: 0 09:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2154b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', '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 09:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:40:07 INFO - Using env: {'DISPLAY': ':0', 09:40:07 INFO - 'HOME': '/home/cltbld', 09:40:07 INFO - 'LANG': 'en_US.UTF-8', 09:40:07 INFO - 'LANGUAGE': 'en_US:en', 09:40:07 INFO - 'LOGNAME': 'cltbld', 09:40:07 INFO - 'MAIL': '/var/mail/cltbld', 09:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:07 INFO - 'MOZ_NO_REMOTE': '1', 09:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:07 INFO - 'NO_EM_RESTART': '1', 09:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:07 INFO - 'PWD': '/builds/slave/test', 09:40:07 INFO - 'SHELL': '/bin/bash', 09:40:07 INFO - 'SHLVL': '1', 09:40:07 INFO - 'TERM': 'linux', 09:40:07 INFO - 'TMOUT': '86400', 09:40:07 INFO - 'USER': 'cltbld', 09:40:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:07 INFO - '_': '/tools/buildbot/bin/python'} 09:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:07 INFO - Cleaning up... 09:40:07 INFO - Return code: 0 09:40:07 INFO - Running post-action listener: _resource_record_post_action 09:40:07 INFO - Running post-action listener: _start_resource_monitoring 09:40:07 INFO - Starting resource monitoring. 09:40:07 INFO - [mozharness: 2017-09-29 16:40:07.883286Z] Finished create-virtualenv step (success) 09:40:07 INFO - [mozharness: 2017-09-29 16:40:07.883756Z] Running install step. 09:40:07 INFO - Running pre-action listener: _resource_record_pre_action 09:40:07 INFO - Running main action method: install 09:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:08 INFO - Reading from file tmpfile_stdout 09:40:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:08 INFO - Reading from file tmpfile_stdout 09:40:08 INFO - Output received: 09:40:08 INFO - Usage: mozinstall [options] installer 09:40:08 INFO - Options: 09:40:08 INFO - -h, --help show this help message and exit 09:40:08 INFO - -d DEST, --destination=DEST 09:40:08 INFO - Directory to install application into. [default: 09:40:08 INFO - "/builds/slave/test"] 09:40:08 INFO - --app=APP Application being installed. [default: firefox] 09:40:08 INFO - mkdir: /builds/slave/test/build/application 09:40:08 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'] 09:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:40:25 INFO - Reading from file tmpfile_stdout 09:40:25 INFO - Output received: 09:40:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:25 INFO - Running post-action listener: _resource_record_post_action 09:40:25 INFO - [mozharness: 2017-09-29 16:40:25.858748Z] Finished install step (success) 09:40:25 INFO - [mozharness: 2017-09-29 16:40:25.859003Z] Running setup-mitmproxy step. 09:40:25 INFO - Running pre-action listener: _resource_record_pre_action 09:40:25 INFO - Running main action method: setup_mitmproxy 09:40:25 INFO - Skipping: mitmproxy is not required 09:40:25 INFO - Running post-action listener: _resource_record_post_action 09:40:25 INFO - [mozharness: 2017-09-29 16:40:25.860159Z] Finished setup-mitmproxy step (success) 09:40:25 INFO - [mozharness: 2017-09-29 16:40:25.860378Z] Running run-tests step. 09:40:25 INFO - Running pre-action listener: _resource_record_pre_action 09:40:25 INFO - Running pre-action listener: _set_gcov_prefix 09:40:25 INFO - Running main action method: run_tests 09:40:25 WARNING - Try message not found. 09:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:25 INFO - Python 2.7.3 09:40:25 INFO - Return code: 0 09:40:25 INFO - grabbing minidump binary from tooltool 09:40:25 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')]} 09:40:25 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 0x22f6d60>, '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 0x22f7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f7ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:25 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 09:40:25 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 09:40:25 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 09:40:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:25 INFO - Return code: 0 09:40:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:25 INFO - ENV: RUST_BACKTRACE is now full 09:40:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 09:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 09:40:25 INFO - Using env: {'DISPLAY': ':0', 09:40:25 INFO - 'HOME': '/home/cltbld', 09:40:25 INFO - 'LANG': 'en_US.UTF-8', 09:40:25 INFO - 'LANGUAGE': 'en_US:en', 09:40:25 INFO - 'LOGNAME': 'cltbld', 09:40:25 INFO - 'MAIL': '/var/mail/cltbld', 09:40:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:25 INFO - 'MOZ_NO_REMOTE': '1', 09:40:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:25 INFO - 'NO_EM_RESTART': '1', 09:40:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:25 INFO - 'PWD': '/builds/slave/test', 09:40:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:25 INFO - 'RUST_BACKTRACE': 'full', 09:40:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:40:25 INFO - 'SHELL': '/bin/bash', 09:40:25 INFO - 'SHLVL': '1', 09:40:25 INFO - 'TERM': 'linux', 09:40:25 INFO - 'TMOUT': '86400', 09:40:25 INFO - 'USER': 'cltbld', 09:40:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:25 INFO - '_': '/tools/buildbot/bin/python'} 09:40:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 09:40:26 INFO - mozversion application_buildid: 20170929151536 09:40:26 INFO - mozversion application_changeset: 935eca685536793ab7df8bfc9fb52d70128f7756 09:40:26 INFO - mozversion application_display_name: Nightly 09:40:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:26 INFO - mozversion application_name: Firefox 09:40:26 INFO - mozversion application_remotingname: firefox 09:40:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:40:26 INFO - mozversion application_vendor: Mozilla 09:40:26 INFO - mozversion application_version: 58.0a1 09:40:26 INFO - mozversion platform_buildid: 20170929151536 09:40:26 INFO - mozversion platform_changeset: 935eca685536793ab7df8bfc9fb52d70128f7756 09:40:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:40:26 INFO - mozversion platform_version: 58.0a1 09:40:26 INFO - using testdate: 1506703226 09:40:26 INFO - actual date: 1506703226 09:40:26 INFO - starting webserver on 'localhost:40096' 09:40:26 INFO - SUITE-START | Running 2 tests 09:40:26 INFO - TEST-START | dromaeo_css 09:40:26 INFO - Initialising browser for dromaeo_css test... 09:40:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40096/getInfo.html -profile /tmp/tmpIxnIgI/profile 09:40:26 INFO - TEST-INFO | started process 5205 (/builds/slave/test/build/application/firefox/firefox http://localhost:40096/getInfo.html) 09:40:32 INFO - TEST-INFO | 5205: exit 0 09:40:32 INFO - Browser initialized. 09:40:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:32 INFO - Using env: {'DISPLAY': ':0', 09:40:32 INFO - 'HOME': '/home/cltbld', 09:40:32 INFO - 'JSGC_DISABLE_POISONING': '1', 09:40:32 INFO - 'LANG': 'en_US.UTF-8', 09:40:32 INFO - 'LANGUAGE': 'en_US:en', 09:40:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:40:32 INFO - 'LOGNAME': 'cltbld', 09:40:32 INFO - 'MAIL': '/var/mail/cltbld', 09:40:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:32 INFO - 'MOZ_CRASHREPORTER': '1', 09:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:40:32 INFO - 'MOZ_NO_REMOTE': '1', 09:40:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:32 INFO - 'NO_EM_RESTART': '1', 09:40:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:32 INFO - 'PWD': '/builds/slave/test', 09:40:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:32 INFO - 'RUST_BACKTRACE': 'full', 09:40:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:40:32 INFO - 'SHELL': '/bin/bash', 09:40:32 INFO - 'SHLVL': '1', 09:40:32 INFO - 'STYLO_FORCE_DISABLED': '1', 09:40:32 INFO - 'TERM': 'linux', 09:40:32 INFO - 'TMOUT': '86400', 09:40:32 INFO - 'USER': 'cltbld', 09:40:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:32 INFO - '_': '/tools/buildbot/bin/python'} 09:40:32 INFO - TEST-INFO | started process 5437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIxnIgI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:32 INFO - PID 5437 | 09:40:32 INFO - PID 5437 | (/builds/slave/test/build/application/firefox/firefox:5487): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:40:32 INFO - PID 5437 | 09:40:43 INFO - PID 5437 | RSS: Main: 141205504 09:40:43 INFO - PID 5437 | 09:43:40 INFO - PID 5437 | Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40096/tests/dromaeo/cssquery-ext.html) 09:43:42 INFO - PID 5437 | RSS: Main: 143101952 09:43:42 INFO - PID 5437 | 09:46:43 INFO - PID 5437 | Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-ext.html (next: http://localhost:40096/tests/dromaeo/cssquery-jquery.html) 09:46:44 INFO - PID 5437 | RSS: Main: 143925248 09:46:44 INFO - PID 5437 | 09:49:45 INFO - PID 5437 | Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40096/tests/dromaeo/cssquery-mootools.html) 09:49:46 INFO - PID 5437 | RSS: Main: 142946304 09:49:46 INFO - PID 5437 | 09:52:48 INFO - PID 5437 | Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40096/tests/dromaeo/cssquery-prototype.html) 09:52:48 INFO - PID 5437 | RSS: Main: 144896000 09:52:48 INFO - PID 5437 | 09:55:51 INFO - PID 5437 | Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40096/tests/dromaeo/cssquery-yui.html) 09:55:52 INFO - PID 5437 | RSS: Main: 147927040 09:55:52 INFO - PID 5437 | 09:58:53 INFO - PID 5437 | Cycle 1(1): loaded http://localhost:40096/tests/dromaeo/cssquery-yui.html (next: http://localhost:40096/tests/dromaeo/cssquery-dojo.html) 09:58:54 INFO - PID 5437 | RSS: Main: 146653184 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | __start_tp_report 09:58:54 INFO - PID 5437 | _x_x_mozilla_page_load 09:58:54 INFO - PID 5437 | _x_x_mozilla_page_load_details 09:58:54 INFO - PID 5437 | |i|pagename|runs| 09:58:54 INFO - PID 5437 | |0;dojo.html;3895.1625400538887;3903.219356128774;3932.4691166692487;3950.071733142711;3968.9206215875665;6276.215473065867;6295.181626388575;6353;6361.363863613637;6402.5518213725;6310.4320611144985;6354.459870910978;6369.681515924197;6376.5855219410705;6396.360363963601;5592.552595792347;5720.942790572103;5738.7991420300295;5784.4504772046585;5803;917.094413317587;5637.492625663689;5693.146028095798;5720.79977200798;5725.742341594618;5268.288781014552;5549.19536667181;5573.804916827912;5585.832425027255;5686.459786320293;5615.073512870372;5639.661620302795;5677.318721753375;5695.458931401552;5700.201971723962;5560.555155587544;5607.467290607386;5613.101903695389;5661.179129026268;5676.460736230051;6248.125262463259;6248.562600617958;6257.87484250317;6274.278457977345;6341.397567231105;6684.632345221011;6811.795646130575;6852.349026842492;6864.7940561783225;6876.965615171942;6869.862602747967;6946.235914049451;6948.513604047668;6949.652517374162;7018.9298107019295;6274.278457977345;6365.427111559982;6386.3613638636225;6454.322296158883;6476.060971159155;6968.09414776086;7133.393661538724;7140.92859071413;7151.570905745672;7158.391536719437;6762.797116086525;6798.354156355138;6862.039314495874;6872.896906546406;6874.828129296808;6822.692978815965;6851.554648947803;6894.862102757917;6942.965285173542;6947.826304342432;6862.794116176423;6931.272216417204;6932.202796678345;6938.861222775517;6953.860922781617;6956.686949087303;6984.895226571605;6991.440684745208;7016.087908571955;7016.92983070173;4989.451160372356;5061.089003979319;5131.025105229995;5131.2559678846355;5145.07388670043;4512.120136573402;4547.15877562652;4583.770811459413;4584.312353147055;4589.036302376471;6338.841528961812;6351.96824015877;6357;6366.522510811707;6366.936330636727;6748.426383757435;6843.281455447206;6847.828804279933;6942.965285173643;6946.235914049451;6230.937690623035;6272.372762723691;6317.747290108344;6339.175907132043;6355.046742988588;5515.972420137874;5536.058869992111;5539.307586551681;5555.916661250085;5610.859728506738;7146.249643787328;7209.0628218331285;7245.094363204599;7249.637518124073;7250.963745181346;6906.896396554156;6918.0314755933205;6920.515563910478;6989.33601307875;6996.790096297119;7017.298270173146;7141.9642901785155;7157.463190260647;7168.4265258780215;7284.089488813898;6798.592084474947;6812.114425124901;6823.044773731583;6835.521513494008;6886.139232595926;6958.617276049663;6993.930060699531;7053.541519801196;7096.645167741695;7101.928980710333;6547.869042619026;6626.337366263335;6665.466762659073;6768.289329620516;6791.558548694319;6717.093192418961;6792.218894827158;6808.863822723617;6809.727610895508;6820.215675197217;6521.706523206372;6606.3393660635475;6613.768518101843;6695.4978376620975;6697.263301036979;6742.022406751092;6744.7639332625085;6766.424853887278;6776.491763117884;6777.661116944035;6537.5750576212395;6546.639934803631;6570.080188773671;6574.506911981716;6632.2372927114 09:58:54 INFO - PID 5437 | |1;ext.html;944.7590864329597;970.0735797313562;973.187388530577;973.1922504321413;978.4765150644405;42836.571634283646;46145;46217.7689111554;46265;46283.76858115713;43752;44071.33892991608;44075.33886991697;44139;44167.55832441674;7441.888371674429;7567.508111972704;8522.914770852305;8735.912640873605;8752.037275899678;8622.35332350073;8688.869666955;8696.782580435476;8697.391182617219;8706.521141337224;8593.527355995418;8642.697505587306;8723.781905452382;8732.8690069649;8745.125487451236;8688.739337819876;8703.390762646586;8732.912670873337;8737.737867863974;8763;8534.061253262198;8598.613062412207;8604.741857744277;8617.138286171396;8626.78433039179;39654.60345396538;39718.40422393666;39785.80107099446;39806.80096599527;40032;3792.1467669774356;3808.1812410331913;3812.8093595320124;3831.04223944014;3831.252905683365;35205.82397087998;35242.82378588116;35269.47095793565;35318.29363412743;35414;5440.129579267338;5446.21029950655;5472.179173124024;5523.889522209573;5605.131204663284;227280;228065;228968;229164;230876.84561577253;49035.26447103296;49632;55360.72319638376;55701.44298556963;56807;59797.40202598005;60029.399706003256;60095;60104;60352.698236509415;17694.469165924784;17831.73252401215;17890.731639025424;17943.102844857705;17956.461306160574;14197.78703319451;14313.928430357782;14333.211673358066;14385;14424.711505769827;16186.19069046543;16188.109653969144;16231.837681623269;16313;16357.754633680504;6297.842553936188;6306.2747784004505;6333.588316759396;6400.935990640127;6465.4827613790785;1098.9780204395868;1099.631623406152;1099.763550836558;1113.0316624536704;1115.252780636975;25503.744962550507;25578.87210563935;25828.483430331664;25896.611550826754;25939.870300648377;1205.1624121235832;1207.7886369885234;1219.2379762648345;1223.7307792285683;1230.723087305349;13693.726125477435;13813.654658633615;13868.791968120486;13875.37560809766;14066.85933140676;292577;293356;293461;294418;295054;61456.692716536134;61804;61814.690926545976;61848.07227891585;61938.38061619416;1521.8478152184693;1586.294099125878;1586.3337398292745;1600.7999000124985;1611.58098894286;26048.739512604632;26070.478590428465;26206;26206.34484137912;26288;43700.12599748051;43960;44036.11927761491;44114.55885441104;44115.77942110269;250706;251665;252946;253341;253966;39647.80176099101;41109;41475.7926210367;41549;41733.58266417419;51210;51775;51803.74098129485;51812.740936296585;51957.74021130022;37453.250934980606;37477.62522374741;37482.43776343302;37681;37866.62133378631;37038.629613704594;37047.62952370442;37452.876413707636;37553.6244637561;37604.32056862193;44715;44763.32855007112;45113.32330015118;45124.77437612791;45138.77430612826;35651.10872228111;35698.10754731153;36044.63955360413;36256.27487450289;36560.63439365679;26108.8694556526;26639.33401664974;26817.731822681522;26853.865730671223;27112.864435677697 09:58:54 INFO - PID 5437 | |2;jquery.html;627.9674563977765;637.2187165138705;640.5194349390193;643.0491082335695;648.9059086432467;23220.30339089828;23956.281311560637;23973.520529589397;23989.64015539766;23996.64005039926;25759.356016099606;26152;26188.738112618867;26210.47579048418;26211;6271.623702577837;6360.9045864312075;6692.9330706693045;6760.188777346725;6790.456763458936;6716.395524402803;6841.9657901710425;6849.657517124124;6850.48621353398;6856.862862742767;6806.285340039299;6807.931920680804;6816.318368163194;6821.18145822502;6821.420179284767;6388.4889208863415;6599.604023758566;6633.800985970381;6642.800715978528;6647.102641143432;6238.251409830804;6241.625502469821;6254.312025677172;6254.937450625481;6262.561620686553;30041.849790751126;30196.396072078434;31248;31358;31378.686213138033;2240.283109404991;2255.842091053627;2260.400993736661;2268.432891777056;2275.6131457652073;20700.896495517427;21343.252986145566;21354.893225533928;21381.67927481089;21559.676604850938;2591.5076135534377;2654.5089158505543;2671.7595416412614;2673.4118493931496;2678.933026674329;147864;154935;157401.21299393428;159776;165784.17107914505;16763.49709508717;16770.245338959776;16873.156342182843;16934.49196524106;17132.14339283031;26756.197314080608;26837.731622683914;26948.32629184286;27058.5941210882;27127.728722712916;11183.496742646601;11333.093352531778;11358.886411135949;11399.430028498542;11437.714057148638;10162.898371016196;10261.333013354108;10305.021023002802;10483;10505.159587233004;9801.509924503745;9991.450470224207;10037.548310326052;10136.645217417356;10292.588296468057;3035.647373285721;3109.70457806508;3110;3123.437781199406;3189.5534625152495;1047.9476026198658;1057.391999600233;1063.324788759128;1067.4555976452066;1076.580133747839;20504.589908201753;20657.793422065886;21224.78775212259;21284.680729789066;21415.46461338479;1104.100158370925;1109.944502774858;1111.9833202501968;1116.3692513729716;1137.0392018744149;11498.655040348804;11794.705132371588;11854.94072529632;11877.109216808602;11912.821307680391;621556;629300;629799;633257;636335;134428;138677;139119.30440347735;140251;142391;1238.102375777554;1268.3721557828933;1279.2963869871533;1284.5760898903338;1284.9614511564669;19236.615267694848;19290.7106393407;19471.513212169244;19755.209791608173;20052.69920951158;62516;63211.36788632055;63912.36087639064;64375.67812161097;65857.34142658512;75418.6229068873;75765.621171896;76078.61960690162;76280.61859690666;76379.61810190913;15951.202439877728;16204.756928646315;16327.836721633106;16372.754408684117;16382.344706211617;24638.384040399134;24758.13346532863;24860.12989545357;25015.624765628167;25068.122615708362;20167.394978150678;20377.18491260333;20535.38393848187;20545.794542054988;20618.69071963952;16323.836761632707;16510;17223.22495487681;17485.12574371302;17586.912065439592;18757.87452752839;19437.31969381065;19503.12235949414;19711.70432443543;19737;15883.761743574087;16092.275847587121;16137.75793363124;16207.108609026616;16227.350905963629;19425.514362140493;19664.115114820153;19739.605207895474;19948.60102797965;20029.699554506984 09:58:54 INFO - PID 5437 | |3;mootools.html;1434.419060280586;1466.7213229486404;1501.8122734658168;1506.0587133041852;1512.8335883052869;16313;16933;16944.491665250032;16944.745828812545;16947.322107115702;16785;16818;16856.494305170832;16874.156292185373;16912;2795.930101747452;2822.5342818434983;2863.3128049268234;2873.0949750828527;2873.6407949006375;2796.105246321178;2816.169230077132;2831.3629433377428;2832.787540934428;2835.631367922167;2693.2324287578044;2784.1508339956304;2802.3974845408234;2814.7326004029583;2854.272160599044;2912.6504819421593;2938.133250691051;2940.4413161499356;2944.749696275819;2945.190072729995;2797.9720202797916;2842.104737007857;2842.4457230839994;2845.1748992792063;2845.445138198052;16614.335426582922;16743.16284185786;16811.32754689811;16827.579310517212;16832.410865619644;7900.249476299742;8099.271065604065;8351.20663536963;8354.498730076155;8357.623906924204;5447.264619276426;5483.616146869721;5575.8884822303735;5592.692401917893;5656.717164141776;2091.602595506849;2134.6477831157995;2139.1122684086085;2183.836212284069;2208.9889550552143;31096.844515777502;31326.21684457884;31393.686063139303;31414.685853141404;31425.52861707099;6732.427743641845;6809.148856392951;6879.724811007603;6917.550359226634;7029.297070293032;19499.122539485757;19579.118939647466;19591.432685385134;19601.313954011828;19650.70523942142;7924.881126783102;8197.672093116327;8215.014198296243;8222.506649601042;8254.133316001853;7544.924550754532;7599.810004749815;7606.353459955855;7629.122650895218;7636.350910172698;5441.421987623545;5591.440855914376;5664.54683625309;5705.771769129271;5819.6508209507565;1600.6958677851171;1663.3928616055296;1669.7912760904887;1687.822778608253;1704.5397742609425;838.5052818836915;959.7600599850037;975.5414954971152;980.4460479828874;999.2206079258191;9916.107550320507;9939.304248702667;10021.549030293509;10170.288079834341;10174.287799854088;770.4375805661898;777.7905357169656;790.1505881177757;790.6718711734566;860.2601762484259;5675.687837168995;5813.476787089182;5861.974154522942;5918.437748413894;5932.79235226765;24265.757342426703;25097.498050038896;25436;25521.74478255231;25523.489530209292;23934.401639959142;24610.630840537407;24858.129965451124;24930.875345623157;25081.874590627296;12181.634550963485;12658.430370633343;12738.681532961566;12875.61373158788;12984.026198034997;9471.857922131312;9690.56392462355;9727.464989425649;9787.51062446889;9803.705888823346;20132.59734805325;20199.79800201979;20394.796052039288;20934.581308373443;21185.682214766483;21071.473213169793;21148.894255529238;21498.462538436663;21648.67526987128;21757;12301.44643491063;12351.629451116482;12402;12518.687032824253;12535;15081.24593770329;15157.772633410728;15214.847851521343;15358.539243822703;15382.538523844303;12166.330851802883;12372.876271237532;12508.499660013498;12547;12551.811722823983;12223.69440763988;12324.568640097912;12485.188462749893;12543.811842822182;12552;10399.428031458343;10655.360678359324;10695.679129626124;10715.678529644123;10744;7919.881201781863;7977.641006154853;8022.117567067735;8069.273765361146;8104.473209241381;8148.5518296494265;8180.222878826502;8218;8219.671213151407;8231.218034286732 09:58:54 INFO - PID 5437 | |4;prototype.html;553.7978637797205;555.4806256150499;579.0561384942545;581.3024370755089;583.4573846322918;6078.179445774819;6184.56708030438;6325.746970121196;6356.745730170787;6399.456046236064;6273.7490500380045;6275.623462592236;6327.873442531147;6332.277120838038;6334.113224148611;5139.331886854704;5176.896462070757;5192;5251.188340022686;5257.185136303879;5219.295395121667;5229.346331708536;5241.266222728821;5243.580513558925;5279.102552566053;5256.001359741656;5256.553192978601;5269.65747226431;5272.156454967206;5280.6039547034125;5209.973950130225;5214.4524824893215;5221.660592061542;5242.79028838846;5243.10867152585;4971.4282857471135;4972.154733695281;4978;4982.800687972477;5019.447860735316;6125.203723515914;6332.936670633281;6366.6180029198395;6397.488200943913;6409.775657851999;6230.5638605297645;6232.376762323776;6240.843978900519;6242.250929888442;6280.183576135073;6727.327267273283;6729.360710732472;6744.527883048188;6776.525643204977;6848.8972665409565;5574;5576.470235327637;5582.469665381782;5598;5646.858828529279;6975.720971161148;6996.8950465743055;7044.506884518086;7096.822579435504;7136.750213742546;5644.153376993484;5685.147227915763;5708.80019199326;5713.5714821388565;5726.770929162787;5764.884702305931;5775.768969241183;5801.88396232073;5812.244408226903;5858.062709966385;6163.568550201532;6193.907091393633;6202.751889924442;6229.906551401733;6246.718897649616;6458.2895881453005;6527.836804079936;6687.164104486939;6692.631905245161;6768;1978.4658142301498;1985.9007049647748;1989.9502512437305;1994.6509360861792;2004.418718571627;1305.2560040776666;1528;1535.4242159190303;1542.7917231173649;1547.7910482084774;5975.940240597625;6117.327094019654;6147.846303842351;6174.845628859314;6203.4416902479;6638.336166383419;6813.591184528944;6842.863142737117;6846.5892046477375;6864.931350686529;6182.1345011698395;6219.875602487925;6238.1890354254565;6258.843528911813;6262.405071518198;3529.311784202056;3610.4042832932796;3615.5480564929385;3624.293262813726;3636.30910127075;6928.272531384233;7012.7545535906;7025.92974070263;7070.39901608369;7075.478772064031;6867;6918.654067296615;6923.273056329113;6953.478489113236;7048.330408611174;7034.437245020488;7089.149302083783;7117.857642847114;7124.216336203013;7182.964085179645;6591;6660.83347916306;6702.966485167543;6704.66476676174;6721.831954201184;6599.241087275025;6637.4690024798865;6667.466602671678;6687.297833727584;6808.28513006147;7094.396976257076;7121.928780712334;7124.964375178091;7174.031505746658;7174.713011479483;5695.174199741097;5715.142428785607;5716.857078573069;5744.195812586157;5756.625819321898;6567.802965911031;6638.601683898982;6813.4549236061985;6821.772081025463;6857.2114206866845;6445.2587952386075;6479.287278399466;6496.902546461902;6611.669416529058;6622.536422450382;6506.544541882212;6578.638174900427;6580.76967306142;6591.373819487141;6618.437432818265;6381.192275398809;6389.552731308764;6393.968030159819;6395.872082558416;6503.284638689645;6069.939300606938;6211.844703882439;6241;6389.552731308764;6564.6389448580785;6336.556441049267;6355.872882542416;6439.839004024937;6473.708683109177;6479.51403644738 09:58:54 INFO - PID 5437 | |5;yui.html;972.4214092614892;991.2615101749195;1023.5036007536348;1024.9955044056824;1031.6028329093297;21234.575308493822;21692.674609880825;21771.455713607167;21822.781772182272;21942.012609432575;19148.904255478737;19576.412707618758;20409.897950510225;20901;20916.26793062243;1072.635303996641;1085.3921803789904;1086.32104934416;1087.6138970665418;1090.0788833435734;1028.110684258115;1072.05123465733;1075.8278675411937;1079.3200283821182;1083.4474418046814;1142.525851771518;1143.2683082826998;1145.37577020524;1145.5017067575588;1149.781541507111;1069.5400977579638;1135.4720055174341;1138.009931359714;1141.497740993964;1147.7933971885057;823.6499487717696;824;825.6986200036944;825.9132791056973;825.9876101858417;21353.572928541344;21389.358319250292;21396.14415423381;21530.138794448205;21557.24549640755;22797.772022279732;23825.285241442612;23920.282391528108;24005.15981940641;24106.156284530134;18461;18746.906265468722;18877.716834247498;18885.244590216374;18897.527561810926;3827.0623697194087;3839.884803455901;3846.9807650961848;3852.5569559500736;3853.2678791029616;166030.16984914997;167278.16360918118;167373;168421.47323836773;168775.99999999878;18348.908255458904;18387;18499.445016649253;18533.629327413644;18919.621607567773;33858.49212261818;33875.83062084723;34044;34327;34610.65389346125;9027.63889444428;9035.412698174729;9076.364654474124;9091.909080909238;9094.81810363789;4554.3168524720895;4585.472670642852;4601.079784043205;4636.44362676481;4670.042641258534;5615.298087739033;5718.7426565804635;5719.7712091516705;5726.885462290731;5730.971345143247;945.4516380499294;977.5649835822991;982.931194816356;983.2527279267665;987.1707765477033;677.7187467201155;692.1659400422479;692.3768608252512;698.7728988078894;700.2017699822206;12233.388330583435;13369.93315033438;13433.596992090253;14055.859441405659;14283.000189986602;750.8986286851315;761.0942977856333;761.9733309334258;768.9615519224017;785.4580339565796;6317.241930968313;6366.26787919386;6379;6449.226092868886;6456.709448074848;143642;144073.27963360326;144221;145386;145455;131456;131615.34192329168;132804;133364;135418;110024.4498777501;110803.44598277118;110893.44553277182;111123;113538;11856.70358241051;11912;11968.102392320785;12044.397780111134;12100.697482563006;55218.44781552133;55740.72129639326;56254.437455626554;56389.718051411124;57373.13940290816;69369;70093.29906701071;70618.29381706323;71655.64172179314;73054.26945730687;16533.50399488017;16570.668586628442;16754.58113547171;16910.57723556921;17036.063016534208;18438.631227375645;18559.16483758261;18709;18778.342758003404;18870.905645472234;16540.503784886474;16680.66638667244;16710.58223544421;16838.831611683727;16885.577860553094;17005.829941700424;17065.573360665585;17122.74315885238;17186.054766987934;17217.22522486516;17016.744748829024;17198.31206751766;17282.481525554253;17383.130843458028;17394.30422783125;11881.168318217988;12000.699982500159;12132;12186.634400967985;12270.509179632714;12613.369331533204;12665.683357916127;12671.746565068832;12753.61739147827;13006 09:58:54 INFO - PID 5437 | __end_tp_report 09:58:54 INFO - PID 5437 | __start_cc_report 09:58:54 INFO - PID 5437 | _x_x_mozilla_cycle_collect,291 09:58:54 INFO - PID 5437 | __end_cc_report 09:58:54 INFO - PID 5437 | __startTimestamp1506704334022__endTimestamp 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | ------- Summary: start ------- 09:58:54 INFO - PID 5437 | Number of tests: 6 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | [#0] dojo.html Cycles:165 Average:6316.84 Median:6626.34 stddev:879.95 (13.3%) stddev-sans-first:861.89 09:58:54 INFO - PID 5437 | Values: 3895.2 3903.2 3932.5 3950.1 3968.9 6276.2 6295.2 6353.0 6361.4 6402.6 6310.4 6354.5 6369.7 6376.6 6396.4 5592.6 5720.9 5738.8 5784.5 5803.0 917.1 5637.5 5693.1 5720.8 5725.7 5268.3 5549.2 5573.8 5585.8 5686.5 5615.1 5639.7 5677.3 5695.5 5700.2 5560.6 5607.5 5613.1 5661.2 5676.5 6248.1 6248.6 6257.9 6274.3 6341.4 6684.6 6811.8 6852.3 6864.8 6877.0 6869.9 6946.2 6948.5 6949.7 7018.9 6274.3 6365.4 6386.4 6454.3 6476.1 6968.1 7133.4 7140.9 7151.6 7158.4 6762.8 6798.4 6862.0 6872.9 6874.8 6822.7 6851.6 6894.9 6943.0 6947.8 6862.8 6931.3 6932.2 6938.9 6953.9 6956.7 6984.9 6991.4 7016.1 7016.9 4989.5 5061.1 5131.0 5131.3 5145.1 4512.1 4547.2 4583.8 4584.3 4589.0 6338.8 6352.0 6357.0 6366.5 6366.9 6748.4 6843.3 6847.8 6943.0 6946.2 6230.9 6272.4 6317.7 6339.2 6355.0 5516.0 5536.1 5539.3 5555.9 5610.9 7146.2 7209.1 7245.1 7249.6 7251.0 6906.9 6918.0 6920.5 6989.3 6996.8 7017.3 7142.0 7157.5 7168.4 7284.1 6798.6 6812.1 6823.0 6835.5 6886.1 6958.6 6993.9 7053.5 7096.6 7101.9 6547.9 6626.3 6665.5 6768.3 6791.6 6717.1 6792.2 6808.9 6809.7 6820.2 6521.7 6606.3 6613.8 6695.5 6697.3 6742.0 6744.8 6766.4 6776.5 6777.7 6537.6 6546.6 6570.1 6574.5 6632.2 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | [#1] ext.html Cycles:180 Average:44781.21 Median:39651.20 stddev:67542.05 (170.3%) stddev-sans-first:67651.32 09:58:54 INFO - PID 5437 | Values: 944.8 970.1 973.2 973.2 978.5 42836.6 46145.0 46217.8 46265.0 46283.8 43752.0 44071.3 44075.3 44139.0 44167.6 7441.9 7567.5 8522.9 8735.9 8752.0 8622.4 8688.9 8696.8 8697.4 8706.5 8593.5 8642.7 8723.8 8732.9 8745.1 8688.7 8703.4 8732.9 8737.7 8763.0 8534.1 8598.6 8604.7 8617.1 8626.8 39654.6 39718.4 39785.8 39806.8 40032.0 3792.1 3808.2 3812.8 3831.0 3831.3 35205.8 35242.8 35269.5 35318.3 35414.0 5440.1 5446.2 5472.2 5523.9 5605.1 227280.0 228065.0 228968.0 229164.0 230876.8 49035.3 49632.0 55360.7 55701.4 56807.0 59797.4 60029.4 60095.0 60104.0 60352.7 17694.5 17831.7 17890.7 17943.1 17956.5 14197.8 14313.9 14333.2 14385.0 14424.7 16186.2 16188.1 16231.8 16313.0 16357.8 6297.8 6306.3 6333.6 6400.9 6465.5 1099.0 1099.6 1099.8 1113.0 1115.3 25503.7 25578.9 25828.5 25896.6 25939.9 1205.2 1207.8 1219.2 1223.7 1230.7 13693.7 13813.7 13868.8 13875.4 14066.9 292577.0 293356.0 293461.0 294418.0 295054.0 61456.7 61804.0 61814.7 61848.1 61938.4 1521.8 1586.3 1586.3 1600.8 1611.6 26048.7 26070.5 26206.0 26206.3 26288.0 43700.1 43960.0 44036.1 44114.6 44115.8 250706.0 251665.0 252946.0 253341.0 253966.0 39647.8 41109.0 41475.8 41549.0 41733.6 51210.0 51775.0 51803.7 51812.7 51957.7 37453.3 37477.6 37482.4 37681.0 37866.6 37038.6 37047.6 37452.9 37553.6 37604.3 44715.0 44763.3 45113.3 45124.8 45138.8 35651.1 35698.1 36044.6 36256.3 36560.6 26108.9 26639.3 26817.7 26853.9 27112.9 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | [#2] jquery.html Cycles:180 Average:40977.13 Median:21398.57 stddev:105476.64 (492.9%) stddev-sans-first:105729.02 09:58:54 INFO - PID 5437 | Values: 628.0 637.2 640.5 643.0 648.9 23220.3 23956.3 23973.5 23989.6 23996.6 25759.4 26152.0 26188.7 26210.5 26211.0 6271.6 6360.9 6692.9 6760.2 6790.5 6716.4 6842.0 6849.7 6850.5 6856.9 6806.3 6807.9 6816.3 6821.2 6821.4 6388.5 6599.6 6633.8 6642.8 6647.1 6238.3 6241.6 6254.3 6254.9 6262.6 30041.8 30196.4 31248.0 31358.0 31378.7 2240.3 2255.8 2260.4 2268.4 2275.6 20700.9 21343.3 21354.9 21381.7 21559.7 2591.5 2654.5 2671.8 2673.4 2678.9 147864.0 154935.0 157401.2 159776.0 165784.2 16763.5 16770.2 16873.2 16934.5 17132.1 26756.2 26837.7 26948.3 27058.6 27127.7 11183.5 11333.1 11358.9 11399.4 11437.7 10162.9 10261.3 10305.0 10483.0 10505.2 9801.5 9991.5 10037.5 10136.6 10292.6 3035.6 3109.7 3110.0 3123.4 3189.6 1047.9 1057.4 1063.3 1067.5 1076.6 20504.6 20657.8 21224.8 21284.7 21415.5 1104.1 1109.9 1112.0 1116.4 1137.0 11498.7 11794.7 11854.9 11877.1 11912.8 621556.0 629300.0 629799.0 633257.0 636335.0 134428.0 138677.0 139119.3 140251.0 142391.0 1238.1 1268.4 1279.3 1284.6 1285.0 19236.6 19290.7 19471.5 19755.2 20052.7 62516.0 63211.4 63912.4 64375.7 65857.3 75418.6 75765.6 76078.6 76280.6 76379.6 15951.2 16204.8 16327.8 16372.8 16382.3 24638.4 24758.1 24860.1 25015.6 25068.1 20167.4 20377.2 20535.4 20545.8 20618.7 16323.8 16510.0 17223.2 17485.1 17586.9 18757.9 19437.3 19503.1 19711.7 19737.0 15883.8 16092.3 16137.8 16207.1 16227.4 19425.5 19664.1 19739.6 19948.6 20029.7 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | [#3] mootools.html Cycles:180 Average:10393.48 Median:2796.02 stddev:7720.03 (276.1%) stddev-sans-first:7712.34 09:58:54 INFO - PID 5437 | Values: 1434.4 1466.7 1501.8 1506.1 1512.8 16313.0 16933.0 16944.5 16944.7 16947.3 16785.0 16818.0 16856.5 16874.2 16912.0 2795.9 2822.5 2863.3 2873.1 2873.6 2796.1 2816.2 2831.4 2832.8 2835.6 2693.2 2784.2 2802.4 2814.7 2854.3 2912.7 2938.1 2940.4 2944.7 2945.2 2798.0 2842.1 2842.4 2845.2 2845.4 16614.3 16743.2 16811.3 16827.6 16832.4 7900.2 8099.3 8351.2 8354.5 8357.6 5447.3 5483.6 5575.9 5592.7 5656.7 2091.6 2134.6 2139.1 2183.8 2209.0 31096.8 31326.2 31393.7 31414.7 31425.5 6732.4 6809.1 6879.7 6917.6 7029.3 19499.1 19579.1 19591.4 19601.3 19650.7 7924.9 8197.7 8215.0 8222.5 8254.1 7544.9 7599.8 7606.4 7629.1 7636.4 5441.4 5591.4 5664.5 5705.8 5819.7 1600.7 1663.4 1669.8 1687.8 1704.5 838.5 959.8 975.5 980.4 999.2 9916.1 9939.3 10021.5 10170.3 10174.3 770.4 777.8 790.2 790.7 860.3 5675.7 5813.5 5862.0 5918.4 5932.8 24265.8 25097.5 25436.0 25521.7 25523.5 23934.4 24610.6 24858.1 24930.9 25081.9 12181.6 12658.4 12738.7 12875.6 12984.0 9471.9 9690.6 9727.5 9787.5 9803.7 20132.6 20199.8 20394.8 20934.6 21185.7 21071.5 21148.9 21498.5 21648.7 21757.0 12301.4 12351.6 12402.0 12518.7 12535.0 15081.2 15157.8 15214.8 15358.5 15382.5 12166.3 12372.9 12508.5 12547.0 12551.8 12223.7 12324.6 12485.2 12543.8 12552.0 10399.4 10655.4 10695.7 10715.7 10744.0 7919.9 7977.6 8022.1 8069.3 8104.5 8148.6 8180.2 8218.0 8219.7 8231.2 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | [#4] prototype.html Cycles:180 Average:5774.89 Median:6274.69 stddev:1530.24 (24.4%) stddev-sans-first:1483.51 09:58:54 INFO - PID 5437 | Values: 553.8 555.5 579.1 581.3 583.5 6078.2 6184.6 6325.7 6356.7 6399.5 6273.7 6275.6 6327.9 6332.3 6334.1 5139.3 5176.9 5192.0 5251.2 5257.2 5219.3 5229.3 5241.3 5243.6 5279.1 5256.0 5256.6 5269.7 5272.2 5280.6 5210.0 5214.5 5221.7 5242.8 5243.1 4971.4 4972.2 4978.0 4982.8 5019.4 6125.2 6332.9 6366.6 6397.5 6409.8 6230.6 6232.4 6240.8 6242.3 6280.2 6727.3 6729.4 6744.5 6776.5 6848.9 5574.0 5576.5 5582.5 5598.0 5646.9 6975.7 6996.9 7044.5 7096.8 7136.8 5644.2 5685.1 5708.8 5713.6 5726.8 5764.9 5775.8 5801.9 5812.2 5858.1 6163.6 6193.9 6202.8 6229.9 6246.7 6458.3 6527.8 6687.2 6692.6 6768.0 1978.5 1985.9 1990.0 1994.7 2004.4 1305.3 1528.0 1535.4 1542.8 1547.8 5975.9 6117.3 6147.8 6174.8 6203.4 6638.3 6813.6 6842.9 6846.6 6864.9 6182.1 6219.9 6238.2 6258.8 6262.4 3529.3 3610.4 3615.5 3624.3 3636.3 6928.3 7012.8 7025.9 7070.4 7075.5 6867.0 6918.7 6923.3 6953.5 7048.3 7034.4 7089.1 7117.9 7124.2 7183.0 6591.0 6660.8 6703.0 6704.7 6721.8 6599.2 6637.5 6667.5 6687.3 6808.3 7094.4 7121.9 7125.0 7174.0 7174.7 5695.2 5715.1 5716.9 5744.2 5756.6 6567.8 6638.6 6813.5 6821.8 6857.2 6445.3 6479.3 6496.9 6611.7 6622.5 6506.5 6578.6 6580.8 6591.4 6618.4 6381.2 6389.6 6394.0 6395.9 6503.3 6069.9 6211.8 6241.0 6389.6 6564.6 6336.6 6355.9 6439.8 6473.7 6479.5 09:58:54 INFO - PID 5437 | 09:58:54 INFO - PID 5437 | [#5] yui.html Cycles:180 Average:28253.83 Median:18727.95 stddev:42476.44 (226.8%) stddev-sans-first:42546.21 09:58:54 INFO - PID 5437 | Values: 972.4 991.3 1023.5 1025.0 1031.6 21234.6 21692.7 21771.5 21822.8 21942.0 19148.9 19576.4 20409.9 20901.0 20916.3 1072.6 1085.4 1086.3 1087.6 1090.1 1028.1 1072.1 1075.8 1079.3 1083.4 1142.5 1143.3 1145.4 1145.5 1149.8 1069.5 1135.5 1138.0 1141.5 1147.8 823.6 824.0 825.7 825.9 826.0 21353.6 21389.4 21396.1 21530.1 21557.2 22797.8 23825.3 23920.3 24005.2 24106.2 18461.0 18746.9 18877.7 18885.2 18897.5 3827.1 3839.9 3847.0 3852.6 3853.3 166030.2 167278.2 167373.0 168421.5 168776.0 18348.9 18387.0 18499.4 18533.6 18919.6 33858.5 33875.8 34044.0 34327.0 34610.7 9027.6 9035.4 9076.4 9091.9 9094.8 4554.3 4585.5 4601.1 4636.4 4670.0 5615.3 5718.7 5719.8 5726.9 5731.0 945.5 977.6 982.9 983.3 987.2 677.7 692.2 692.4 698.8 700.2 12233.4 13369.9 13433.6 14055.9 14283.0 750.9 761.1 762.0 769.0 785.5 6317.2 6366.3 6379.0 6449.2 6456.7 143642.0 144073.3 144221.0 145386.0 145455.0 131456.0 131615.3 132804.0 133364.0 135418.0 110024.4 110803.4 110893.4 111123.0 113538.0 11856.7 11912.0 11968.1 12044.4 12100.7 55218.4 55740.7 56254.4 56389.7 57373.1 69369.0 70093.3 70618.3 71655.6 73054.3 16533.5 16570.7 16754.6 16910.6 17036.1 18438.6 18559.2 18709.0 18778.3 18870.9 16540.5 16680.7 16710.6 16838.8 16885.6 17005.8 17065.6 17122.7 17186.1 17217.2 17016.7 17198.3 17282.5 17383.1 17394.3 11881.2 12000.7 12132.0 12186.6 12270.5 12613.4 12665.7 12671.7 12753.6 13006.0 09:58:54 INFO - PID 5437 | -------- Summary: end -------- 09:58:54 INFO - PID 5437 | 09:58:54 INFO - TEST-INFO | 5437: exit 0 09:58:54 INFO - TEST-OK | dromaeo_css | took 1108346ms 09:58:54 INFO - TEST-START | kraken 09:58:54 INFO - Initialising browser for kraken test... 09:58:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40096/getInfo.html -profile /tmp/tmpYGtVWf/profile 09:58:54 INFO - TEST-INFO | started process 5796 (/builds/slave/test/build/application/firefox/firefox http://localhost:40096/getInfo.html) 09:58:59 INFO - TEST-INFO | 5796: exit 0 09:58:59 INFO - Browser initialized. 09:58:59 INFO - Running cycle 1/1 for kraken test... 09:58:59 INFO - Using env: {'DISPLAY': ':0', 09:58:59 INFO - 'HOME': '/home/cltbld', 09:58:59 INFO - 'JSGC_DISABLE_POISONING': '1', 09:58:59 INFO - 'LANG': 'en_US.UTF-8', 09:58:59 INFO - 'LANGUAGE': 'en_US:en', 09:58:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:58:59 INFO - 'LOGNAME': 'cltbld', 09:58:59 INFO - 'MAIL': '/var/mail/cltbld', 09:58:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:59 INFO - 'MOZ_CRASHREPORTER': '1', 09:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:58:59 INFO - 'MOZ_NO_REMOTE': '1', 09:58:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:59 INFO - 'NO_EM_RESTART': '1', 09:58:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:59 INFO - 'PWD': '/builds/slave/test', 09:58:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:59 INFO - 'RUST_BACKTRACE': 'full', 09:58:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:58:59 INFO - 'SHELL': '/bin/bash', 09:58:59 INFO - 'SHLVL': '1', 09:58:59 INFO - 'STYLO_FORCE_DISABLED': '1', 09:58:59 INFO - 'TERM': 'linux', 09:58:59 INFO - 'TMOUT': '86400', 09:58:59 INFO - 'USER': 'cltbld', 09:58:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472', 09:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:59 INFO - '_': '/tools/buildbot/bin/python'} 09:58:59 INFO - TEST-INFO | started process 6034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYGtVWf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:00 INFO - PID 6034 | 09:59:00 INFO - PID 6034 | (/builds/slave/test/build/application/firefox/firefox:6084): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:59:00 INFO - PID 6034 | 09:59:10 INFO - PID 6034 | RSS: Main: 145096704 09:59:10 INFO - PID 6034 | 09:59:13 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:14 INFO - PID 6034 | RSS: Main: 151060480 09:59:14 INFO - PID 6034 | 09:59:16 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-dft) 09:59:17 INFO - PID 6034 | RSS: Main: 151474176 09:59:17 INFO - PID 6034 | 09:59:20 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-fft) 09:59:21 INFO - PID 6034 | RSS: Main: 148070400 09:59:21 INFO - PID 6034 | 09:59:23 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40096/tests/kraken/driver.html?testName=audio-oscillator) 09:59:23 INFO - PID 6034 | RSS: Main: 148783104 09:59:23 INFO - PID 6034 | 09:59:25 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:26 INFO - PID 6034 | RSS: Main: 148672512 09:59:26 INFO - PID 6034 | 09:59:29 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40096/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:30 INFO - PID 6034 | RSS: Main: 148709376 09:59:30 INFO - PID 6034 | 09:59:33 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40096/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:34 INFO - PID 6034 | RSS: Main: 149839872 09:59:34 INFO - PID 6034 | 09:59:37 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40096/tests/kraken/driver.html?testName=json-parse-financial) 09:59:37 INFO - PID 6034 | RSS: Main: 151752704 09:59:37 INFO - PID 6034 | 09:59:39 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:39 INFO - PID 6034 | RSS: Main: 151560192 09:59:39 INFO - PID 6034 | 09:59:41 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:41 INFO - PID 6034 | RSS: Main: 151367680 09:59:41 INFO - PID 6034 | 09:59:43 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:44 INFO - PID 6034 | RSS: Main: 148635648 09:59:44 INFO - PID 6034 | 09:59:47 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:47 INFO - PID 6034 | RSS: Main: 148426752 09:59:47 INFO - PID 6034 | 09:59:50 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:50 INFO - PID 6034 | RSS: Main: 149139456 09:59:50 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | Cycle 1(1): loaded http://localhost:40096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40096/tests/kraken/driver.html?testName=ai-astar) 09:59:52 INFO - PID 6034 | RSS: Main: 150663168 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | __start_tp_report 09:59:52 INFO - PID 6034 | _x_x_mozilla_page_load 09:59:52 INFO - PID 6034 | _x_x_mozilla_page_load_details 09:59:52 INFO - PID 6034 | |i|pagename|runs| 09:59:52 INFO - PID 6034 | |0;ai-astar;108;106;104;105;105;108;106;104;104;107 09:59:52 INFO - PID 6034 | |1;audio-beat-detection;114;115;115;114;141;113;111;137;116;116 09:59:52 INFO - PID 6034 | |2;audio-dft;163;162;161;162;162;163;162;162;161;171 09:59:52 INFO - PID 6034 | |3;audio-fft;75;73;75;72;73;74;73;74;74;74 09:59:52 INFO - PID 6034 | |4;audio-oscillator;80;79;83;78;77;76;77;78;78;77 09:59:52 INFO - PID 6034 | |5;imaging-gaussian-blur;111;111;112;111;117;112;112;113;111;112 09:59:52 INFO - PID 6034 | |6;imaging-darkroom;150;149;148;151;150;149;150;150;149;150 09:59:52 INFO - PID 6034 | |7;imaging-desaturate;95;94;94;93;95;93;94;94;94;94 09:59:52 INFO - PID 6034 | |8;json-parse-financial;47;44;47;44;45;44;54;45;45;45 09:59:52 INFO - PID 6034 | |9;json-stringify-tinderbox;36;36;36;37;36;36;36;36;35;35 09:59:52 INFO - PID 6034 | |10;stanford-crypto-aes;71;72;70;72;73;72;72;77;73;71 09:59:52 INFO - PID 6034 | |11;stanford-crypto-ccm;108;104;104;104;109;102;107;106;108;103 09:59:52 INFO - PID 6034 | |12;stanford-crypto-pbkdf2;156;152;152;156;157;149;152;150;156;151 09:59:52 INFO - PID 6034 | |13;stanford-crypto-sha256-iterative;60;59;59;59;61;58;83;59;59;62 09:59:52 INFO - PID 6034 | __end_tp_report 09:59:52 INFO - PID 6034 | __start_cc_report 09:59:52 INFO - PID 6034 | _x_x_mozilla_cycle_collect,724 09:59:52 INFO - PID 6034 | __end_cc_report 09:59:52 INFO - PID 6034 | __startTimestamp1506704392899__endTimestamp 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | ------- Summary: start ------- 09:59:52 INFO - PID 6034 | Number of tests: 14 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.00 stddev:1.57 (1.5%) stddev-sans-first:1.42 09:59:52 INFO - PID 6034 | Values: 108.0 106.0 104.0 105.0 105.0 108.0 106.0 104.0 104.0 107.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:115.50 stddev:10.58 (9.2%) stddev-sans-first:11.05 09:59:52 INFO - PID 6034 | Values: 114.0 115.0 115.0 114.0 141.0 113.0 111.0 137.0 116.0 116.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:2.92 (1.8%) stddev-sans-first:3.10 09:59:52 INFO - PID 6034 | Values: 163.0 162.0 161.0 162.0 162.0 163.0 162.0 162.0 161.0 171.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:0.95 (1.3%) stddev-sans-first:0.88 09:59:52 INFO - PID 6034 | Values: 75.0 73.0 75.0 72.0 73.0 74.0 73.0 74.0 74.0 74.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:78.00 stddev:2.00 (2.6%) stddev-sans-first:2.03 09:59:52 INFO - PID 6034 | Values: 80.0 79.0 83.0 78.0 77.0 76.0 77.0 78.0 78.0 77.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#5] imaging-gaussian-blur Cycles:10 Average:112.20 Median:112.00 stddev:1.81 (1.6%) stddev-sans-first:1.87 09:59:52 INFO - PID 6034 | Values: 111.0 111.0 112.0 111.0 117.0 112.0 112.0 113.0 111.0 112.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 09:59:52 INFO - PID 6034 | Values: 150.0 149.0 148.0 151.0 150.0 149.0 150.0 150.0 149.0 150.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 09:59:52 INFO - PID 6034 | Values: 95.0 94.0 94.0 93.0 95.0 93.0 94.0 94.0 94.0 94.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:45.00 stddev:3.02 (6.7%) stddev-sans-first:3.18 09:59:52 INFO - PID 6034 | Values: 47.0 44.0 47.0 44.0 45.0 44.0 54.0 45.0 45.0 45.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#9] json-stringify-tinderbox Cycles:10 Average:35.90 Median:36.00 stddev:0.57 (1.6%) stddev-sans-first:0.60 09:59:52 INFO - PID 6034 | Values: 36.0 36.0 36.0 37.0 36.0 36.0 36.0 36.0 35.0 35.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:1.89 (2.6%) stddev-sans-first:1.94 09:59:52 INFO - PID 6034 | Values: 71.0 72.0 70.0 72.0 73.0 72.0 72.0 77.0 73.0 71.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#11] stanford-crypto-ccm Cycles:10 Average:105.50 Median:106.50 stddev:2.42 (2.3%) stddev-sans-first:2.39 09:59:52 INFO - PID 6034 | Values: 108.0 104.0 104.0 104.0 109.0 102.0 107.0 106.0 108.0 103.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:2.88 (1.9%) stddev-sans-first:2.86 09:59:52 INFO - PID 6034 | Values: 156.0 152.0 152.0 156.0 157.0 149.0 152.0 150.0 156.0 151.0 09:59:52 INFO - PID 6034 | 09:59:52 INFO - PID 6034 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:59.50 stddev:7.50 (12.6%) stddev-sans-first:7.93 09:59:52 INFO - PID 6034 | Values: 60.0 59.0 59.0 59.0 61.0 58.0 83.0 59.0 59.0 62.0 09:59:52 INFO - PID 6034 | -------- Summary: end -------- 09:59:52 INFO - PID 6034 | 09:59:53 INFO - PID 6034 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:59:53 INFO - TEST-INFO | 6034: exit 0 09:59:53 INFO - TEST-OK | kraken | took 58964ms 09:59:53 INFO - SUITE-END | took 1167s 09:59:53 INFO - Completed test suite (00:19:27) 09:59:53 INFO - javascript benchmark 09:59:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9200.245893808564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3895.1625400538887, 3903.219356128774, 3932.4691166692487, 3950.071733142711, 3968.9206215875665, 6276.215473065867, 6295.181626388575, 6353.0, 6361.363863613637, 6402.5518213725, 6310.4320611144985, 6354.459870910978, 6369.681515924197, 6376.5855219410705, 6396.360363963601, 5592.552595792347, 5720.942790572103, 5738.7991420300295, 5784.4504772046585, 5803.0, 917.094413317587, 5637.492625663689, 5693.146028095798, 5720.79977200798, 5725.742341594618, 5268.288781014552, 5549.19536667181, 5573.804916827912, 5585.832425027255, 5686.459786320293, 5615.073512870372, 5639.661620302795, 5677.318721753375, 5695.458931401552, 5700.201971723962, 5560.555155587544, 5607.467290607386, 5613.101903695389, 5661.179129026268, 5676.460736230051, 6248.125262463259, 6248.562600617958, 6257.87484250317, 6274.278457977345, 6341.397567231105, 6684.632345221011, 6811.795646130575, 6852.349026842492, 6864.7940561783225, 6876.965615171942, 6869.862602747967, 6946.235914049451, 6948.513604047668, 6949.652517374162, 7018.9298107019295, 6274.278457977345, 6365.427111559982, 6386.3613638636225, 6454.322296158883, 6476.060971159155, 6968.09414776086, 7133.393661538724, 7140.92859071413, 7151.570905745672, 7158.391536719437, 6762.797116086525, 6798.354156355138, 6862.039314495874, 6872.896906546406, 6874.828129296808, 6822.692978815965, 6851.554648947803, 6894.862102757917, 6942.965285173542, 6947.826304342432, 6862.794116176423, 6931.272216417204, 6932.202796678345, 6938.861222775517, 6953.860922781617, 6956.686949087303, 6984.895226571605, 6991.440684745208, 7016.087908571955, 7016.92983070173, 4989.451160372356, 5061.089003979319, 5131.025105229995, 5131.2559678846355, 5145.07388670043, 4512.120136573402, 4547.15877562652, 4583.770811459413, 4584.312353147055, 4589.036302376471, 6338.841528961812, 6351.96824015877, 6357.0, 6366.522510811707, 6366.936330636727, 6748.426383757435, 6843.281455447206, 6847.828804279933, 6942.965285173643, 6946.235914049451, 6230.937690623035, 6272.372762723691, 6317.747290108344, 6339.175907132043, 6355.046742988588, 5515.972420137874, 5536.058869992111, 5539.307586551681, 5555.916661250085, 5610.859728506738, 7146.249643787328, 7209.0628218331285, 7245.094363204599, 7249.637518124073, 7250.963745181346, 6906.896396554156, 6918.0314755933205, 6920.515563910478, 6989.33601307875, 6996.790096297119, 7017.298270173146, 7141.9642901785155, 7157.463190260647, 7168.4265258780215, 7284.089488813898, 6798.592084474947, 6812.114425124901, 6823.044773731583, 6835.521513494008, 6886.139232595926, 6958.617276049663, 6993.930060699531, 7053.541519801196, 7096.645167741695, 7101.928980710333, 6547.869042619026, 6626.337366263335, 6665.466762659073, 6768.289329620516, 6791.558548694319, 6717.093192418961, 6792.218894827158, 6808.863822723617, 6809.727610895508, 6820.215675197217, 6521.706523206372, 6606.3393660635475, 6613.768518101843, 6695.4978376620975, 6697.263301036979, 6742.022406751092, 6744.7639332625085, 6766.424853887278, 6776.491763117884, 6777.661116944035, 6537.5750576212395, 6546.639934803631, 6570.080188773671, 6574.506911981716, 6632.2372927114], "value": 6257.374088243161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.7590864329597, 970.0735797313562, 973.187388530577, 973.1922504321413, 978.4765150644405, 42836.571634283646, 46145.0, 46217.7689111554, 46265.0, 46283.76858115713, 43752.0, 44071.33892991608, 44075.33886991697, 44139.0, 44167.55832441674, 7441.888371674429, 7567.508111972704, 8522.914770852305, 8735.912640873605, 8752.037275899678, 8622.35332350073, 8688.869666955, 8696.782580435476, 8697.391182617219, 8706.521141337224, 8593.527355995418, 8642.697505587306, 8723.781905452382, 8732.8690069649, 8745.125487451236, 8688.739337819876, 8703.390762646586, 8732.912670873337, 8737.737867863974, 8763.0, 8534.061253262198, 8598.613062412207, 8604.741857744277, 8617.138286171396, 8626.78433039179, 39654.60345396538, 39718.40422393666, 39785.80107099446, 39806.80096599527, 40032.0, 3792.1467669774356, 3808.1812410331913, 3812.8093595320124, 3831.04223944014, 3831.252905683365, 35205.82397087998, 35242.82378588116, 35269.47095793565, 35318.29363412743, 35414.0, 5440.129579267338, 5446.21029950655, 5472.179173124024, 5523.889522209573, 5605.131204663284, 227280.0, 228065.0, 228968.0, 229164.0, 230876.84561577253, 49035.26447103296, 49632.0, 55360.72319638376, 55701.44298556963, 56807.0, 59797.40202598005, 60029.399706003256, 60095.0, 60104.0, 60352.698236509415, 17694.469165924784, 17831.73252401215, 17890.731639025424, 17943.102844857705, 17956.461306160574, 14197.78703319451, 14313.928430357782, 14333.211673358066, 14385.0, 14424.711505769827, 16186.19069046543, 16188.109653969144, 16231.837681623269, 16313.0, 16357.754633680504, 6297.842553936188, 6306.2747784004505, 6333.588316759396, 6400.935990640127, 6465.4827613790785, 1098.9780204395868, 1099.631623406152, 1099.763550836558, 1113.0316624536704, 1115.252780636975, 25503.744962550507, 25578.87210563935, 25828.483430331664, 25896.611550826754, 25939.870300648377, 1205.1624121235832, 1207.7886369885234, 1219.2379762648345, 1223.7307792285683, 1230.723087305349, 13693.726125477435, 13813.654658633615, 13868.791968120486, 13875.37560809766, 14066.85933140676, 292577.0, 293356.0, 293461.0, 294418.0, 295054.0, 61456.692716536134, 61804.0, 61814.690926545976, 61848.07227891585, 61938.38061619416, 1521.8478152184693, 1586.294099125878, 1586.3337398292745, 1600.7999000124985, 1611.58098894286, 26048.739512604632, 26070.478590428465, 26206.0, 26206.34484137912, 26288.0, 43700.12599748051, 43960.0, 44036.11927761491, 44114.55885441104, 44115.77942110269, 250706.0, 251665.0, 252946.0, 253341.0, 253966.0, 39647.80176099101, 41109.0, 41475.7926210367, 41549.0, 41733.58266417419, 51210.0, 51775.0, 51803.74098129485, 51812.740936296585, 51957.74021130022, 37453.250934980606, 37477.62522374741, 37482.43776343302, 37681.0, 37866.62133378631, 37038.629613704594, 37047.62952370442, 37452.876413707636, 37553.6244637561, 37604.32056862193, 44715.0, 44763.32855007112, 45113.32330015118, 45124.77437612791, 45138.77430612826, 35651.10872228111, 35698.10754731153, 36044.63955360413, 36256.27487450289, 36560.63439365679, 26108.8694556526, 26639.33401664974, 26817.731822681522, 26853.865730671223, 27112.864435677697], "value": 19482.422672244058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.9674563977765, 637.2187165138705, 640.5194349390193, 643.0491082335695, 648.9059086432467, 23220.30339089828, 23956.281311560637, 23973.520529589397, 23989.64015539766, 23996.64005039926, 25759.356016099606, 26152.0, 26188.738112618867, 26210.47579048418, 26211.0, 6271.623702577837, 6360.9045864312075, 6692.9330706693045, 6760.188777346725, 6790.456763458936, 6716.395524402803, 6841.9657901710425, 6849.657517124124, 6850.48621353398, 6856.862862742767, 6806.285340039299, 6807.931920680804, 6816.318368163194, 6821.18145822502, 6821.420179284767, 6388.4889208863415, 6599.604023758566, 6633.800985970381, 6642.800715978528, 6647.102641143432, 6238.251409830804, 6241.625502469821, 6254.312025677172, 6254.937450625481, 6262.561620686553, 30041.849790751126, 30196.396072078434, 31248.0, 31358.0, 31378.686213138033, 2240.283109404991, 2255.842091053627, 2260.400993736661, 2268.432891777056, 2275.6131457652073, 20700.896495517427, 21343.252986145566, 21354.893225533928, 21381.67927481089, 21559.676604850938, 2591.5076135534377, 2654.5089158505543, 2671.7595416412614, 2673.4118493931496, 2678.933026674329, 147864.0, 154935.0, 157401.21299393428, 159776.0, 165784.17107914505, 16763.49709508717, 16770.245338959776, 16873.156342182843, 16934.49196524106, 17132.14339283031, 26756.197314080608, 26837.731622683914, 26948.32629184286, 27058.5941210882, 27127.728722712916, 11183.496742646601, 11333.093352531778, 11358.886411135949, 11399.430028498542, 11437.714057148638, 10162.898371016196, 10261.333013354108, 10305.021023002802, 10483.0, 10505.159587233004, 9801.509924503745, 9991.450470224207, 10037.548310326052, 10136.645217417356, 10292.588296468057, 3035.647373285721, 3109.70457806508, 3110.0, 3123.437781199406, 3189.5534625152495, 1047.9476026198658, 1057.391999600233, 1063.324788759128, 1067.4555976452066, 1076.580133747839, 20504.589908201753, 20657.793422065886, 21224.78775212259, 21284.680729789066, 21415.46461338479, 1104.100158370925, 1109.944502774858, 1111.9833202501968, 1116.3692513729716, 1137.0392018744149, 11498.655040348804, 11794.705132371588, 11854.94072529632, 11877.109216808602, 11912.821307680391, 621556.0, 629300.0, 629799.0, 633257.0, 636335.0, 134428.0, 138677.0, 139119.30440347735, 140251.0, 142391.0, 1238.102375777554, 1268.3721557828933, 1279.2963869871533, 1284.5760898903338, 1284.9614511564669, 19236.615267694848, 19290.7106393407, 19471.513212169244, 19755.209791608173, 20052.69920951158, 62516.0, 63211.36788632055, 63912.36087639064, 64375.67812161097, 65857.34142658512, 75418.6229068873, 75765.621171896, 76078.61960690162, 76280.61859690666, 76379.61810190913, 15951.202439877728, 16204.756928646315, 16327.836721633106, 16372.754408684117, 16382.344706211617, 24638.384040399134, 24758.13346532863, 24860.12989545357, 25015.624765628167, 25068.122615708362, 20167.394978150678, 20377.18491260333, 20535.38393848187, 20545.794542054988, 20618.69071963952, 16323.836761632707, 16510.0, 17223.22495487681, 17485.12574371302, 17586.912065439592, 18757.87452752839, 19437.31969381065, 19503.12235949414, 19711.70432443543, 19737.0, 15883.761743574087, 16092.275847587121, 16137.75793363124, 16207.108609026616, 16227.350905963629, 19425.514362140493, 19664.115114820153, 19739.605207895474, 19948.60102797965, 20029.699554506984], "value": 13038.140864773317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.419060280586, 1466.7213229486404, 1501.8122734658168, 1506.0587133041852, 1512.8335883052869, 16313.0, 16933.0, 16944.491665250032, 16944.745828812545, 16947.322107115702, 16785.0, 16818.0, 16856.494305170832, 16874.156292185373, 16912.0, 2795.930101747452, 2822.5342818434983, 2863.3128049268234, 2873.0949750828527, 2873.6407949006375, 2796.105246321178, 2816.169230077132, 2831.3629433377428, 2832.787540934428, 2835.631367922167, 2693.2324287578044, 2784.1508339956304, 2802.3974845408234, 2814.7326004029583, 2854.272160599044, 2912.6504819421593, 2938.133250691051, 2940.4413161499356, 2944.749696275819, 2945.190072729995, 2797.9720202797916, 2842.104737007857, 2842.4457230839994, 2845.1748992792063, 2845.445138198052, 16614.335426582922, 16743.16284185786, 16811.32754689811, 16827.579310517212, 16832.410865619644, 7900.249476299742, 8099.271065604065, 8351.20663536963, 8354.498730076155, 8357.623906924204, 5447.264619276426, 5483.616146869721, 5575.8884822303735, 5592.692401917893, 5656.717164141776, 2091.602595506849, 2134.6477831157995, 2139.1122684086085, 2183.836212284069, 2208.9889550552143, 31096.844515777502, 31326.21684457884, 31393.686063139303, 31414.685853141404, 31425.52861707099, 6732.427743641845, 6809.148856392951, 6879.724811007603, 6917.550359226634, 7029.297070293032, 19499.122539485757, 19579.118939647466, 19591.432685385134, 19601.313954011828, 19650.70523942142, 7924.881126783102, 8197.672093116327, 8215.014198296243, 8222.506649601042, 8254.133316001853, 7544.924550754532, 7599.810004749815, 7606.353459955855, 7629.122650895218, 7636.350910172698, 5441.421987623545, 5591.440855914376, 5664.54683625309, 5705.771769129271, 5819.6508209507565, 1600.6958677851171, 1663.3928616055296, 1669.7912760904887, 1687.822778608253, 1704.5397742609425, 838.5052818836915, 959.7600599850037, 975.5414954971152, 980.4460479828874, 999.2206079258191, 9916.107550320507, 9939.304248702667, 10021.549030293509, 10170.288079834341, 10174.287799854088, 770.4375805661898, 777.7905357169656, 790.1505881177757, 790.6718711734566, 860.2601762484259, 5675.687837168995, 5813.476787089182, 5861.974154522942, 5918.437748413894, 5932.79235226765, 24265.757342426703, 25097.498050038896, 25436.0, 25521.74478255231, 25523.489530209292, 23934.401639959142, 24610.630840537407, 24858.129965451124, 24930.875345623157, 25081.874590627296, 12181.634550963485, 12658.430370633343, 12738.681532961566, 12875.61373158788, 12984.026198034997, 9471.857922131312, 9690.56392462355, 9727.464989425649, 9787.51062446889, 9803.705888823346, 20132.59734805325, 20199.79800201979, 20394.796052039288, 20934.581308373443, 21185.682214766483, 21071.473213169793, 21148.894255529238, 21498.462538436663, 21648.67526987128, 21757.0, 12301.44643491063, 12351.629451116482, 12402.0, 12518.687032824253, 12535.0, 15081.24593770329, 15157.772633410728, 15214.847851521343, 15358.539243822703, 15382.538523844303, 12166.330851802883, 12372.876271237532, 12508.499660013498, 12547.0, 12551.811722823983, 12223.69440763988, 12324.568640097912, 12485.188462749893, 12543.811842822182, 12552.0, 10399.428031458343, 10655.360678359324, 10695.679129626124, 10715.678529644123, 10744.0, 7919.881201781863, 7977.641006154853, 8022.117567067735, 8069.273765361146, 8104.473209241381, 8148.5518296494265, 8180.222878826502, 8218.0, 8219.671213151407, 8231.218034286732], "value": 7258.078371218032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.7978637797205, 555.4806256150499, 579.0561384942545, 581.3024370755089, 583.4573846322918, 6078.179445774819, 6184.56708030438, 6325.746970121196, 6356.745730170787, 6399.456046236064, 6273.7490500380045, 6275.623462592236, 6327.873442531147, 6332.277120838038, 6334.113224148611, 5139.331886854704, 5176.896462070757, 5192.0, 5251.188340022686, 5257.185136303879, 5219.295395121667, 5229.346331708536, 5241.266222728821, 5243.580513558925, 5279.102552566053, 5256.001359741656, 5256.553192978601, 5269.65747226431, 5272.156454967206, 5280.6039547034125, 5209.973950130225, 5214.4524824893215, 5221.660592061542, 5242.79028838846, 5243.10867152585, 4971.4282857471135, 4972.154733695281, 4978.0, 4982.800687972477, 5019.447860735316, 6125.203723515914, 6332.936670633281, 6366.6180029198395, 6397.488200943913, 6409.775657851999, 6230.5638605297645, 6232.376762323776, 6240.843978900519, 6242.250929888442, 6280.183576135073, 6727.327267273283, 6729.360710732472, 6744.527883048188, 6776.525643204977, 6848.8972665409565, 5574.0, 5576.470235327637, 5582.469665381782, 5598.0, 5646.858828529279, 6975.720971161148, 6996.8950465743055, 7044.506884518086, 7096.822579435504, 7136.750213742546, 5644.153376993484, 5685.147227915763, 5708.80019199326, 5713.5714821388565, 5726.770929162787, 5764.884702305931, 5775.768969241183, 5801.88396232073, 5812.244408226903, 5858.062709966385, 6163.568550201532, 6193.907091393633, 6202.751889924442, 6229.906551401733, 6246.718897649616, 6458.2895881453005, 6527.836804079936, 6687.164104486939, 6692.631905245161, 6768.0, 1978.4658142301498, 1985.9007049647748, 1989.9502512437305, 1994.6509360861792, 2004.418718571627, 1305.2560040776666, 1528.0, 1535.4242159190303, 1542.7917231173649, 1547.7910482084774, 5975.940240597625, 6117.327094019654, 6147.846303842351, 6174.845628859314, 6203.4416902479, 6638.336166383419, 6813.591184528944, 6842.863142737117, 6846.5892046477375, 6864.931350686529, 6182.1345011698395, 6219.875602487925, 6238.1890354254565, 6258.843528911813, 6262.405071518198, 3529.311784202056, 3610.4042832932796, 3615.5480564929385, 3624.293262813726, 3636.30910127075, 6928.272531384233, 7012.7545535906, 7025.92974070263, 7070.39901608369, 7075.478772064031, 6867.0, 6918.654067296615, 6923.273056329113, 6953.478489113236, 7048.330408611174, 7034.437245020488, 7089.149302083783, 7117.857642847114, 7124.216336203013, 7182.964085179645, 6591.0, 6660.83347916306, 6702.966485167543, 6704.66476676174, 6721.831954201184, 6599.241087275025, 6637.4690024798865, 6667.466602671678, 6687.297833727584, 6808.28513006147, 7094.396976257076, 7121.928780712334, 7124.964375178091, 7174.031505746658, 7174.713011479483, 5695.174199741097, 5715.142428785607, 5716.857078573069, 5744.195812586157, 5756.625819321898, 6567.802965911031, 6638.601683898982, 6813.4549236061985, 6821.772081025463, 6857.2114206866845, 6445.2587952386075, 6479.287278399466, 6496.902546461902, 6611.669416529058, 6622.536422450382, 6506.544541882212, 6578.638174900427, 6580.76967306142, 6591.373819487141, 6618.437432818265, 6381.192275398809, 6389.552731308764, 6393.968030159819, 6395.872082558416, 6503.284638689645, 6069.939300606938, 6211.844703882439, 6241.0, 6389.552731308764, 6564.6389448580785, 6336.556441049267, 6355.872882542416, 6439.839004024937, 6473.708683109177, 6479.51403644738], "value": 5343.935473440789, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.4214092614892, 991.2615101749195, 1023.5036007536348, 1024.9955044056824, 1031.6028329093297, 21234.575308493822, 21692.674609880825, 21771.455713607167, 21822.781772182272, 21942.012609432575, 19148.904255478737, 19576.412707618758, 20409.897950510225, 20901.0, 20916.26793062243, 1072.635303996641, 1085.3921803789904, 1086.32104934416, 1087.6138970665418, 1090.0788833435734, 1028.110684258115, 1072.05123465733, 1075.8278675411937, 1079.3200283821182, 1083.4474418046814, 1142.525851771518, 1143.2683082826998, 1145.37577020524, 1145.5017067575588, 1149.781541507111, 1069.5400977579638, 1135.4720055174341, 1138.009931359714, 1141.497740993964, 1147.7933971885057, 823.6499487717696, 824.0, 825.6986200036944, 825.9132791056973, 825.9876101858417, 21353.572928541344, 21389.358319250292, 21396.14415423381, 21530.138794448205, 21557.24549640755, 22797.772022279732, 23825.285241442612, 23920.282391528108, 24005.15981940641, 24106.156284530134, 18461.0, 18746.906265468722, 18877.716834247498, 18885.244590216374, 18897.527561810926, 3827.0623697194087, 3839.884803455901, 3846.9807650961848, 3852.5569559500736, 3853.2678791029616, 166030.16984914997, 167278.16360918118, 167373.0, 168421.47323836773, 168775.99999999878, 18348.908255458904, 18387.0, 18499.445016649253, 18533.629327413644, 18919.621607567773, 33858.49212261818, 33875.83062084723, 34044.0, 34327.0, 34610.65389346125, 9027.63889444428, 9035.412698174729, 9076.364654474124, 9091.909080909238, 9094.81810363789, 4554.3168524720895, 4585.472670642852, 4601.079784043205, 4636.44362676481, 4670.042641258534, 5615.298087739033, 5718.7426565804635, 5719.7712091516705, 5726.885462290731, 5730.971345143247, 945.4516380499294, 977.5649835822991, 982.931194816356, 983.2527279267665, 987.1707765477033, 677.7187467201155, 692.1659400422479, 692.3768608252512, 698.7728988078894, 700.2017699822206, 12233.388330583435, 13369.93315033438, 13433.596992090253, 14055.859441405659, 14283.000189986602, 750.8986286851315, 761.0942977856333, 761.9733309334258, 768.9615519224017, 785.4580339565796, 6317.241930968313, 6366.26787919386, 6379.0, 6449.226092868886, 6456.709448074848, 143642.0, 144073.27963360326, 144221.0, 145386.0, 145455.0, 131456.0, 131615.34192329168, 132804.0, 133364.0, 135418.0, 110024.4498777501, 110803.44598277118, 110893.44553277182, 111123.0, 113538.0, 11856.70358241051, 11912.0, 11968.102392320785, 12044.397780111134, 12100.697482563006, 55218.44781552133, 55740.72129639326, 56254.437455626554, 56389.718051411124, 57373.13940290816, 69369.0, 70093.29906701071, 70618.29381706323, 71655.64172179314, 73054.26945730687, 16533.50399488017, 16570.668586628442, 16754.58113547171, 16910.57723556921, 17036.063016534208, 18438.631227375645, 18559.16483758261, 18709.0, 18778.342758003404, 18870.905645472234, 16540.503784886474, 16680.66638667244, 16710.58223544421, 16838.831611683727, 16885.577860553094, 17005.829941700424, 17065.573360665585, 17122.74315885238, 17186.054766987934, 17217.22522486516, 17016.744748829024, 17198.31206751766, 17282.481525554253, 17383.130843458028, 17394.30422783125, 11881.168318217988, 12000.699982500159, 12132.0, 12186.634400967985, 12270.509179632714, 12613.369331533204, 12665.683357916127, 12671.746565068832, 12753.61739147827, 13006.0], "value": 9836.395259083547, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1370.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 104.0, 105.0, 105.0, 108.0, 106.0, 104.0, 104.0, 107.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 141.0, 113.0, 111.0, 137.0, 116.0, 116.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 171.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 72.0, 73.0, 74.0, 73.0, 74.0, 74.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 83.0, 78.0, 77.0, 76.0, 77.0, 78.0, 78.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 111.0, 117.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 151.0, 150.0, 149.0, 150.0, 150.0, 149.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 93.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 44.0, 47.0, 44.0, 45.0, 44.0, 54.0, 45.0, 45.0, 45.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 37.0, 36.0, 36.0, 36.0, 36.0, 35.0, 35.0], "value": 35.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 70.0, 72.0, 73.0, 72.0, 72.0, 77.0, 73.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 104.0, 104.0, 104.0, 109.0, 102.0, 107.0, 106.0, 108.0, 103.0], "value": 105.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 152.0, 156.0, 157.0, 149.0, 152.0, 150.0, 156.0, 151.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 61.0, 58.0, 83.0, 59.0, 59.0, 62.0], "value": 61.9, "unit": "score"}]}]} 09:59:53 INFO - Return code: 0 09:59:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:53 INFO - # TBPL SUCCESS # 09:59:53 INFO - Running post-action listener: _package_coverage_data 09:59:53 INFO - Running post-action listener: _resource_record_post_action 09:59:53 INFO - [mozharness: 2017-09-29 16:59:53.672525Z] Finished run-tests step (success) 09:59:53 INFO - Running post-run listener: _resource_record_post_run 09:59:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 434176; Write bytes: 388018176; Read time: 612; Write time: 270148 09:59:53 INFO - TinderboxPrint: CPU usage
13.1% 09:59:53 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 612 09:59:53 INFO - TinderboxPrint: I/O write bytes / time
388,018,176 / 270,148 09:59:53 INFO - TinderboxPrint: CPU idle
8,210.9 (86.9%) 09:59:53 INFO - TinderboxPrint: CPU user
1,187.0 (12.6%) 09:59:53 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 75300864; Read time: 184; Write time: 43304 09:59:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:59:53 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 430080; Write bytes: 312717312; Read time: 428; Write time: 226844 09:59:54 INFO - Running post-run listener: _upload_blobber_files 09:59:54 INFO - Blob upload gear active. 09:59:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:54 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 09:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:59:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 09:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 09:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:55 INFO - (blobuploader) - INFO - Done attempting. 09:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:03 INFO - (blobuploader) - INFO - Done attempting. 10:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 10:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 10:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:04 INFO - (blobuploader) - INFO - Done attempting. 10:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:05 INFO - (blobuploader) - INFO - Done attempting. 10:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:05 INFO - Return code: 0 10:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1cc118411d57245fb0a413d6463f80c6b5523ee4b3419db4f44f5d188c66910ffa0ee4096a993f1a7ed4af975f866707901076b59efcbc219179a1c64764fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02af895143576218918a18f3a1381d613538520189ffcd719d038f0d7517e081228e1a62df89a9a10939c86aa9a3a82f4f02ba43bb2f33ab54ca2e3f933daac0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a890523b1b48c9342d10b52d5851f72290393550aaed5ac35353f747ae159462055ac97986f26f6e66185e6793f4bde2a6321ac10c15bdf4431c0f9c5722c51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445671999c47e1e054be2996c30af195d61e7db53f5c7507c4271a00763e7d992080e7abbc5736acae562ac194e04977f66e30812d96b058c2a3ae0464552d4"} 10:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:05 INFO - Contents: 10:00:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1cc118411d57245fb0a413d6463f80c6b5523ee4b3419db4f44f5d188c66910ffa0ee4096a993f1a7ed4af975f866707901076b59efcbc219179a1c64764fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02af895143576218918a18f3a1381d613538520189ffcd719d038f0d7517e081228e1a62df89a9a10939c86aa9a3a82f4f02ba43bb2f33ab54ca2e3f933daac0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a890523b1b48c9342d10b52d5851f72290393550aaed5ac35353f747ae159462055ac97986f26f6e66185e6793f4bde2a6321ac10c15bdf4431c0f9c5722c51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445671999c47e1e054be2996c30af195d61e7db53f5c7507c4271a00763e7d992080e7abbc5736acae562ac194e04977f66e30812d96b058c2a3ae0464552d4"} 10:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:05 INFO - Copying logs to upload dir... 10:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.195113 ========= master_lag: 0.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 10:00:06.386967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 10:00:06.391275) ========= 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=ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1cc118411d57245fb0a413d6463f80c6b5523ee4b3419db4f44f5d188c66910ffa0ee4096a993f1a7ed4af975f866707901076b59efcbc219179a1c64764fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02af895143576218918a18f3a1381d613538520189ffcd719d038f0d7517e081228e1a62df89a9a10939c86aa9a3a82f4f02ba43bb2f33ab54ca2e3f933daac0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a890523b1b48c9342d10b52d5851f72290393550aaed5ac35353f747ae159462055ac97986f26f6e66185e6793f4bde2a6321ac10c15bdf4431c0f9c5722c51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445671999c47e1e054be2996c30af195d61e7db53f5c7507c4271a00763e7d992080e7abbc5736acae562ac194e04977f66e30812d96b058c2a3ae0464552d4"} build_url:https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/KTzW7DnASLiFmbwUj_DZhg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e1cc118411d57245fb0a413d6463f80c6b5523ee4b3419db4f44f5d188c66910ffa0ee4096a993f1a7ed4af975f866707901076b59efcbc219179a1c64764fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02af895143576218918a18f3a1381d613538520189ffcd719d038f0d7517e081228e1a62df89a9a10939c86aa9a3a82f4f02ba43bb2f33ab54ca2e3f933daac0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a890523b1b48c9342d10b52d5851f72290393550aaed5ac35353f747ae159462055ac97986f26f6e66185e6793f4bde2a6321ac10c15bdf4431c0f9c5722c51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6445671999c47e1e054be2996c30af195d61e7db53f5c7507c4271a00763e7d992080e7abbc5736acae562ac194e04977f66e30812d96b058c2a3ae0464552d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 10:00:06.419439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 10:00:06.419748) ========= 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=ed14279e38b05397cf4aa391000001a4-1506701891.566071-2005299472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 10:00:06.473751) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 10:00:06.474063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 10:00:06.474354) ========= ========= Total master_lag: 0.89 =========