builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-002 starttime: 1506561622.44 results: success (0) revision: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.443551) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.443994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.444271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.461349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.461769) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 18:20:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.1M=0.001s 2017-09-27 18:20:22 (21.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.671521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.671940) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017146 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:22.724460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 18:20:22.724819) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 --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 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 --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=a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 18:20:22,769 truncating revision to first 12 chars 2017-09-27 18:20:22,769 Setting DEBUG logging. 2017-09-27 18:20:22,769 attempt 1/10 2017-09-27 18:20:22,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ebe2e8980c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 18:20:24,150 unpacking tar archive at: mozilla-central-5ebe2e8980c6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.682249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 18:20:24.423497) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:24.423827) ========= script_repo_revision: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:24.424195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:24.428490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 18:20:24.445219) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-27 18:20:24.445621) ========= /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=a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:24 INFO - MultiFileLogger online at 20170927 18:20:24 in /builds/slave/test 18:20:24 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 18:20:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:24 INFO - {'append_to_log': False, 18:20:24 INFO - 'base_work_dir': '/builds/slave/test', 18:20:24 INFO - 'blob_upload_branch': 'Firefox', 18:20:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:24 INFO - 'branch': 'Firefox', 18:20:24 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:24 INFO - 'code_coverage': False, 18:20:24 INFO - 'config_files': ('talos/linux_config.py',), 18:20:24 INFO - 'default_actions': ('clobber', 18:20:24 INFO - 'read-buildbot-config', 18:20:24 INFO - 'download-and-extract', 18:20:24 INFO - 'populate-webroot', 18:20:24 INFO - 'create-virtualenv', 18:20:24 INFO - 'install', 18:20:24 INFO - 'setup-mitmproxy', 18:20:24 INFO - 'run-tests'), 18:20:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:24 INFO - 'disable_ccov_upload': False, 18:20:24 INFO - 'disable_stylo': False, 18:20:24 INFO - 'download_minidump_stackwalk': True, 18:20:24 INFO - 'download_symbols': 'ondemand', 18:20:24 INFO - 'enable_stylo': False, 18:20:24 INFO - 'enable_webrender': False, 18:20:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:20:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:24 INFO - 'gecko_profile': False, 18:20:24 INFO - 'gecko_profile_interval': 0, 18:20:24 INFO - 'installer_path': 'installer.exe', 18:20:24 INFO - 'log_level': 'info', 18:20:24 INFO - 'log_name': 'talos', 18:20:24 INFO - 'log_to_console': True, 18:20:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:24 INFO - 'opt_config_files': (), 18:20:24 INFO - 'pip_index': False, 18:20:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 18:20:24 INFO - 'system_bits': '32', 18:20:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:24 INFO - 'title': 'talos-linux64-ix-002', 18:20:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:24 INFO - 'use_talos_json': True, 18:20:24 INFO - 'verify': 'False', 18:20:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:24 INFO - 'work_dir': 'build'} 18:20:24 INFO - [mozharness: 2017-09-28 01:20:24.642276Z] Running clobber step. 18:20:24 INFO - Running pre-action listener: _resource_record_pre_action 18:20:24 INFO - Running main action method: clobber 18:20:24 INFO - rmtree: /builds/slave/test/build 18:20:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:26 INFO - Running post-action listener: _resource_record_post_action 18:20:26 INFO - [mozharness: 2017-09-28 01:20:26.158226Z] Finished clobber step (success) 18:20:26 INFO - [mozharness: 2017-09-28 01:20:26.158324Z] Running read-buildbot-config step. 18:20:26 INFO - Running pre-action listener: _resource_record_pre_action 18:20:26 INFO - Running main action method: read_buildbot_config 18:20:26 INFO - Using buildbot properties: 18:20:26 INFO - { 18:20:26 INFO - "project": "", 18:20:26 INFO - "product": "firefox", 18:20:26 INFO - "who": "kwierso@gmail.com", 18:20:26 INFO - "installer_path": "public/build/target.tar.bz2", 18:20:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 18:20:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:20:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 18:20:26 INFO - "stage_platform": "linux64-pgo", 18:20:26 INFO - "basedir": "/builds/slave/test", 18:20:26 INFO - "buildnumber": 68, 18:20:26 INFO - "platform": "ubuntu64_hw", 18:20:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:20:26 INFO - "slavebuilddir": "test", 18:20:26 INFO - "taskId": "COJ-JDD7S2m0ScHqexdKKg", 18:20:26 INFO - "branch": "mozilla-central", 18:20:26 INFO - "script_repo_revision": "production", 18:20:26 INFO - "revision": "5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369", 18:20:26 INFO - "slavename": "talos-linux64-ix-002", 18:20:26 INFO - "repo_path": "mozilla-central" 18:20:26 INFO - } 18:20:26 INFO - Finding installer, test and symbols from parent task. 18:20:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/COJ-JDD7S2m0ScHqexdKKg'}, attempt #1 18:20:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/COJ-JDD7S2m0ScHqexdKKg'}, attempt #1 18:20:27 INFO - Task dependencies: Nd2wp_F6SlCE3VuynIQczQ 18:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ'}, attempt #1 18:20:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2 18:20:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.test_packages.json 18:20:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.crashreporter-symbols.zip 18:20:27 INFO - Running post-action listener: _resource_record_post_action 18:20:27 INFO - [mozharness: 2017-09-28 01:20:27.734435Z] Finished read-buildbot-config step (success) 18:20:27 INFO - [mozharness: 2017-09-28 01:20:27.734654Z] Running download-and-extract step. 18:20:27 INFO - Running pre-action listener: _resource_record_pre_action 18:20:27 INFO - Running main action method: download_and_extract 18:20:27 INFO - mkdir: /builds/slave/test/build/tests 18:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:27 INFO - trying https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.test_packages.json 18:20:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:20:28 INFO - Downloaded 989 bytes. 18:20:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:20:28 INFO - Using the following test package requirements: 18:20:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:20:28 INFO - u'common': [u'target.common.tests.zip'], 18:20:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:20:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:20:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:20:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:20:28 INFO - u'mozbase': [u'target.common.tests.zip'], 18:20:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:20:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:20:28 INFO - u'web-platform': [u'target.common.tests.zip', 18:20:28 INFO - u'target.web-platform.tests.tar.gz'], 18:20:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:20:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:20:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.common.tests.zip 18:20:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:20:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.common.tests.zip into memory 18:20:29 INFO - Content-Length response header: 55351016 18:20:29 INFO - Bytes received: 55351016 18:20:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.talos.tests.zip 18:20:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:20:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.talos.tests.zip into memory 18:20:41 INFO - Content-Length response header: 14521162 18:20:41 INFO - Bytes received: 14521162 18:20:41 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')]} 18:20:41 INFO - trying https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2 18:20:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:20:42 INFO - Downloaded 62424915 bytes. 18:20:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2 18:20:42 INFO - mkdir: /builds/slave/test/properties 18:20:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:42 INFO - Contents: 18:20:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2 18:20:42 INFO - Running post-action listener: _resource_record_post_action 18:20:42 INFO - Running post-action listener: find_tests_for_verification 18:20:42 INFO - Running post-action listener: set_extra_try_arguments 18:20:42 INFO - [mozharness: 2017-09-28 01:20:42.704439Z] Finished download-and-extract step (success) 18:20:42 INFO - [mozharness: 2017-09-28 01:20:42.704542Z] Running populate-webroot step. 18:20:42 INFO - Running pre-action listener: _resource_record_pre_action 18:20:42 INFO - Running main action method: populate_webroot 18:20:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:20:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['tresize', 18:20:42 INFO - 'tcanvasmark']}, 18:20:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:20:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['dromaeo_css', 18:20:42 INFO - 'kraken']}, 18:20:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'tests': ['damp', 'tps']}, 18:20:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['damp', 'tps']}, 18:20:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['dromaeo_dom']}, 18:20:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:20:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['basic_compositor_video', 18:20:42 INFO - 'glvideo']}, 18:20:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:20:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['ts_paint_webext', 18:20:42 INFO - 'tp5o_webext']}, 18:20:42 INFO - 'other-e10s': {'tests': ['a11yr', 18:20:42 INFO - 'ts_paint', 18:20:42 INFO - 'tpaint', 18:20:42 INFO - 'sessionrestore', 18:20:42 INFO - 'sessionrestore_many_windows', 18:20:42 INFO - 'sessionrestore_no_auto_restore', 18:20:42 INFO - 'tabpaint', 18:20:42 INFO - 'cpstartup']}, 18:20:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['a11yr', 18:20:42 INFO - 'ts_paint', 18:20:42 INFO - 'tpaint', 18:20:42 INFO - 'sessionrestore', 18:20:42 INFO - 'sessionrestore_many_windows', 18:20:42 INFO - 'sessionrestore_no_auto_restore', 18:20:42 INFO - 'tabpaint', 18:20:42 INFO - 'cpstartup']}, 18:20:42 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 18:20:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:20:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['perf_reftest_singletons']}, 18:20:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['perf_reftest']}, 18:20:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:20:42 INFO - 'tsvgr_opacity', 18:20:42 INFO - 'tart', 18:20:42 INFO - 'tscrollx', 18:20:42 INFO - 'tsvg_static']}, 18:20:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['tsvgx', 18:20:42 INFO - 'tsvgr_opacity', 18:20:42 INFO - 'tart', 18:20:42 INFO - 'tscrollx', 18:20:42 INFO - 'tsvg_static']}, 18:20:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:20:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'talos_options': ['--disable-stylo'], 18:20:42 INFO - 'tests': ['tp5o']}, 18:20:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:20:42 INFO - 'talos_options': ['--mitmproxy', 18:20:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:42 INFO - '--firstNonBlankPaint'], 18:20:42 INFO - 'tests': ['tp6_google', 18:20:42 INFO - 'tp6_youtube', 18:20:42 INFO - 'tp6_amazon', 18:20:42 INFO - 'tp6_facebook']}, 18:20:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:20:42 INFO - 'talos_options': ['--disable-stylo', 18:20:42 INFO - '--mitmproxy', 18:20:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:42 INFO - '--firstNonBlankPaint'], 18:20:42 INFO - 'tests': ['tp6_google', 18:20:42 INFO - 'tp6_youtube', 18:20:42 INFO - 'tp6_amazon', 18:20:42 INFO - 'tp6_facebook']}, 18:20:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:20:42 INFO - 'talos_options': ['--stylo-threads=1', 18:20:42 INFO - '--mitmproxy', 18:20:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:42 INFO - '--firstNonBlankPaint'], 18:20:42 INFO - 'tests': ['tp6_google', 18:20:42 INFO - 'tp6_youtube', 18:20:42 INFO - 'tp6_amazon', 18:20:42 INFO - 'tp6_facebook']}, 18:20:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'talos_options': ['--xperf_path', 18:20:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:42 INFO - 'tests': ['tp5n']}, 18:20:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:20:42 INFO - 'talos_options': ['--disable-stylo', 18:20:42 INFO - '--xperf_path', 18:20:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:42 INFO - 'tests': ['tp5n']}}} 18:20:42 INFO - Running post-action listener: _resource_record_post_action 18:20:42 INFO - [mozharness: 2017-09-28 01:20:42.720521Z] Finished populate-webroot step (success) 18:20:42 INFO - [mozharness: 2017-09-28 01:20:42.720611Z] Running create-virtualenv step. 18:20:42 INFO - Running pre-action listener: _resource_record_pre_action 18:20:42 INFO - Running main action method: create_virtualenv 18:20:42 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:20:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:20:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:20:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:43 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:43 INFO - Installing pip...............done. 18:20:43 INFO - Return code: 0 18:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:20:43 INFO - Reading from file tmpfile_stdout 18:20:43 INFO - Output received: 18:20:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:20:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:43 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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:43 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 18:20:43 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 18:20:43 INFO - Using env: {'DISPLAY': ':0', 18:20:43 INFO - 'HOME': '/home/cltbld', 18:20:43 INFO - 'LANG': 'en_US.UTF-8', 18:20:43 INFO - 'LANGUAGE': 'en_US:en', 18:20:43 INFO - 'LOGNAME': 'cltbld', 18:20:43 INFO - 'MAIL': '/var/mail/cltbld', 18:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:43 INFO - 'MOZ_NO_REMOTE': '1', 18:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:43 INFO - 'NO_EM_RESTART': '1', 18:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:43 INFO - 'PWD': '/builds/slave/test', 18:20:43 INFO - 'SHELL': '/bin/bash', 18:20:43 INFO - 'SHLVL': '1', 18:20:43 INFO - 'TERM': 'linux', 18:20:43 INFO - 'TMOUT': '86400', 18:20:43 INFO - 'USER': 'cltbld', 18:20:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:43 INFO - '_': '/tools/buildbot/bin/python'} 18:20:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:20:44 INFO - Downloading/unpacking pip>=1.5 18:20:44 INFO - Running setup.py egg_info for package pip 18:20:44 INFO - warning: no files found matching 'pip/cacert.pem' 18:20:44 INFO - warning: no files found matching '*.html' under directory 'docs' 18:20:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:20:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:20:44 INFO - Installing collected packages: pip 18:20:44 INFO - Found existing installation: pip 1.1 18:20:44 INFO - Uninstalling pip: 18:20:44 INFO - Successfully uninstalled pip 18:20:44 INFO - Running setup.py install for pip 18:20:44 INFO - warning: no files found matching 'pip/cacert.pem' 18:20:44 INFO - warning: no files found matching '*.html' under directory 'docs' 18:20:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:20:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:20:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:20:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:20:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:20:44 INFO - Successfully installed pip 18:20:44 INFO - Cleaning up... 18:20:44 INFO - Return code: 0 18:20:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20: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')]} 18:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:44 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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:44 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 18:20:44 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 18:20:44 INFO - Using env: {'DISPLAY': ':0', 18:20:44 INFO - 'HOME': '/home/cltbld', 18:20:44 INFO - 'LANG': 'en_US.UTF-8', 18:20:44 INFO - 'LANGUAGE': 'en_US:en', 18:20:44 INFO - 'LOGNAME': 'cltbld', 18:20:44 INFO - 'MAIL': '/var/mail/cltbld', 18:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:44 INFO - 'MOZ_NO_REMOTE': '1', 18:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:44 INFO - 'NO_EM_RESTART': '1', 18:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:44 INFO - 'PWD': '/builds/slave/test', 18:20:44 INFO - 'SHELL': '/bin/bash', 18:20:44 INFO - 'SHLVL': '1', 18:20:44 INFO - 'TERM': 'linux', 18:20:44 INFO - 'TMOUT': '86400', 18:20:44 INFO - 'USER': 'cltbld', 18:20:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:44 INFO - '_': '/tools/buildbot/bin/python'} 18:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:45 INFO - Downloading/unpacking psutil>=3.1.1 18:20:45 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 18:20:45 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 18:20:45 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 18:20:45 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 18:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:46 INFO - Installing collected packages: psutil 18:20:46 INFO - Running setup.py install for psutil 18:20:46 INFO - building 'psutil._psutil_linux' extension 18:20:46 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 18:20:46 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 18:20:46 INFO - building 'psutil._psutil_posix' extension 18:20:46 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 18:20:46 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 18:20:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:46 INFO - Successfully installed psutil 18:20:46 INFO - Cleaning up... 18:20:46 INFO - Return code: 0 18:20:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:20:46 INFO - Using env: {'DISPLAY': ':0', 18:20:46 INFO - 'HOME': '/home/cltbld', 18:20:46 INFO - 'LANG': 'en_US.UTF-8', 18:20:46 INFO - 'LANGUAGE': 'en_US:en', 18:20:46 INFO - 'LOGNAME': 'cltbld', 18:20:46 INFO - 'MAIL': '/var/mail/cltbld', 18:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:46 INFO - 'MOZ_NO_REMOTE': '1', 18:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:46 INFO - 'NO_EM_RESTART': '1', 18:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:46 INFO - 'PWD': '/builds/slave/test', 18:20:46 INFO - 'SHELL': '/bin/bash', 18:20:46 INFO - 'SHLVL': '1', 18:20:46 INFO - 'TERM': 'linux', 18:20:46 INFO - 'TMOUT': '86400', 18:20:46 INFO - 'USER': 'cltbld', 18:20:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:46 INFO - '_': '/tools/buildbot/bin/python'} 18:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:20:48 INFO - Installing collected packages: mozsystemmonitor 18:20:48 INFO - Running setup.py install for mozsystemmonitor 18:20:48 INFO - Successfully installed mozsystemmonitor 18:20:48 INFO - Cleaning up... 18:20:49 INFO - Return code: 0 18:20:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20: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')]} 18:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20: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', '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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:20: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 jsonschema==2.5.1 18:20:49 INFO - Using env: {'DISPLAY': ':0', 18:20:49 INFO - 'HOME': '/home/cltbld', 18:20:49 INFO - 'LANG': 'en_US.UTF-8', 18:20:49 INFO - 'LANGUAGE': 'en_US:en', 18:20:49 INFO - 'LOGNAME': 'cltbld', 18:20:49 INFO - 'MAIL': '/var/mail/cltbld', 18:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:49 INFO - 'MOZ_NO_REMOTE': '1', 18:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:49 INFO - 'NO_EM_RESTART': '1', 18:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:49 INFO - 'PWD': '/builds/slave/test', 18:20:49 INFO - 'SHELL': '/bin/bash', 18:20:49 INFO - 'SHLVL': '1', 18:20:49 INFO - 'TERM': 'linux', 18:20:49 INFO - 'TMOUT': '86400', 18:20:49 INFO - 'USER': 'cltbld', 18:20:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:49 INFO - '_': '/tools/buildbot/bin/python'} 18:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:49 INFO - Downloading/unpacking jsonschema==2.5.1 18:20: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 18:20: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 18:20: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 18:20: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 18:20:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:20:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:20:50 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 18:20:50 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 18:20:50 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 18:20:50 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 18:20:50 INFO - Downloading functools32-3.2.3-2.tar.gz 18:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:20:50 INFO - warning: no files found matching '*.txt' 18:20:50 INFO - no previously-included directories found matching 'build' 18:20:50 INFO - no previously-included directories found matching 'dist' 18:20:50 INFO - no previously-included directories found matching '.git*' 18:20:50 INFO - Installing collected packages: jsonschema, functools32 18:20:51 INFO - Running setup.py install for functools32 18:20:51 INFO - warning: no files found matching '*.txt' 18:20:51 INFO - no previously-included directories found matching 'build' 18:20:51 INFO - no previously-included directories found matching 'dist' 18:20:51 INFO - no previously-included directories found matching '.git*' 18:20:51 INFO - Successfully installed jsonschema functools32 18:20:51 INFO - Cleaning up... 18:20:51 INFO - Return code: 0 18:20:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:20:51 INFO - Using env: {'DISPLAY': ':0', 18:20:51 INFO - 'HOME': '/home/cltbld', 18:20:51 INFO - 'LANG': 'en_US.UTF-8', 18:20:51 INFO - 'LANGUAGE': 'en_US:en', 18:20:51 INFO - 'LOGNAME': 'cltbld', 18:20:51 INFO - 'MAIL': '/var/mail/cltbld', 18:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:51 INFO - 'MOZ_NO_REMOTE': '1', 18:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:51 INFO - 'NO_EM_RESTART': '1', 18:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:51 INFO - 'PWD': '/builds/slave/test', 18:20:51 INFO - 'SHELL': '/bin/bash', 18:20:51 INFO - 'SHLVL': '1', 18:20:51 INFO - 'TERM': 'linux', 18:20:51 INFO - 'TMOUT': '86400', 18:20:51 INFO - 'USER': 'cltbld', 18:20:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:51 INFO - '_': '/tools/buildbot/bin/python'} 18:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:20:51 INFO - Cleaning up... 18:20:51 INFO - Return code: 0 18:20:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:20:51 INFO - Using env: {'DISPLAY': ':0', 18:20:51 INFO - 'HOME': '/home/cltbld', 18:20:51 INFO - 'LANG': 'en_US.UTF-8', 18:20:51 INFO - 'LANGUAGE': 'en_US:en', 18:20:51 INFO - 'LOGNAME': 'cltbld', 18:20:51 INFO - 'MAIL': '/var/mail/cltbld', 18:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:51 INFO - 'MOZ_NO_REMOTE': '1', 18:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:51 INFO - 'NO_EM_RESTART': '1', 18:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:51 INFO - 'PWD': '/builds/slave/test', 18:20:51 INFO - 'SHELL': '/bin/bash', 18:20:51 INFO - 'SHLVL': '1', 18:20:51 INFO - 'TERM': 'linux', 18:20:51 INFO - 'TMOUT': '86400', 18:20:51 INFO - 'USER': 'cltbld', 18:20:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:51 INFO - '_': '/tools/buildbot/bin/python'} 18:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:51 INFO - Downloading/unpacking blobuploader==1.2.4 18:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:20:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:20: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 18:20: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 18:20: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 18:20: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 18:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:20:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:20: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 18:20: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 18:20: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 18:20: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 18:20:53 INFO - Downloading docopt-0.6.1.tar.gz 18:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:20:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:20:53 INFO - Running setup.py install for blobuploader 18:20:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:20:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:20:53 INFO - Running setup.py install for requests 18:20:54 INFO - Running setup.py install for docopt 18:20:54 INFO - Successfully installed blobuploader requests docopt 18:20:54 INFO - Cleaning up... 18:20:54 INFO - Return code: 0 18:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20: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')]} 18:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:54 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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:54 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 18:20:54 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 18:20:54 INFO - Using env: {'DISPLAY': ':0', 18:20:54 INFO - 'HOME': '/home/cltbld', 18:20:54 INFO - 'LANG': 'en_US.UTF-8', 18:20:54 INFO - 'LANGUAGE': 'en_US:en', 18:20:54 INFO - 'LOGNAME': 'cltbld', 18:20:54 INFO - 'MAIL': '/var/mail/cltbld', 18:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:54 INFO - 'MOZ_NO_REMOTE': '1', 18:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:54 INFO - 'NO_EM_RESTART': '1', 18:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:54 INFO - 'PWD': '/builds/slave/test', 18:20:54 INFO - 'SHELL': '/bin/bash', 18:20:54 INFO - 'SHLVL': '1', 18:20:54 INFO - 'TERM': 'linux', 18:20:54 INFO - 'TMOUT': '86400', 18:20:54 INFO - 'USER': 'cltbld', 18:20:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:54 INFO - '_': '/tools/buildbot/bin/python'} 18:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:54 INFO - Running setup.py (path:/tmp/pip-JhjLuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:54 INFO - Running setup.py (path:/tmp/pip-8hoexF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:54 INFO - Running setup.py (path:/tmp/pip-rc7NzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:54 INFO - Running setup.py (path:/tmp/pip-R_mcuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:54 INFO - Running setup.py (path:/tmp/pip-DCprEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:54 INFO - Running setup.py (path:/tmp/pip-HjI0sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:54 INFO - Running setup.py (path:/tmp/pip-aNaIsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:55 INFO - Running setup.py (path:/tmp/pip-Sq08x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:55 INFO - Running setup.py (path:/tmp/pip-jHF4jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:55 INFO - Running setup.py (path:/tmp/pip-l2QWKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:55 INFO - Running setup.py (path:/tmp/pip-j3yNl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:55 INFO - Running setup.py (path:/tmp/pip-O1Bda_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:55 INFO - Running setup.py (path:/tmp/pip-0Z7BLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:55 INFO - Running setup.py (path:/tmp/pip-1i59fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:55 INFO - Running setup.py (path:/tmp/pip-WIc2fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:55 INFO - Running setup.py (path:/tmp/pip-7D5dgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:55 INFO - Running setup.py (path:/tmp/pip-OPmIZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:20:55 INFO - Running setup.py install for manifestparser 18:20:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:20:55 INFO - Running setup.py install for mozcrash 18:20:55 INFO - Running setup.py install for mozdebug 18:20:56 INFO - Running setup.py install for mozdevice 18:20:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Running setup.py install for mozfile 18:20:56 INFO - Running setup.py install for mozhttpd 18:20:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Running setup.py install for mozinfo 18:20:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Running setup.py install for mozInstall 18:20:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Running setup.py install for mozleak 18:20:56 INFO - Running setup.py install for mozlog 18:20:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Running setup.py install for moznetwork 18:20:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:20:56 INFO - Running setup.py install for mozprocess 18:20:56 INFO - Running setup.py install for mozprofile 18:20:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:20:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:20:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:20:57 INFO - Running setup.py install for mozrunner 18:20:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:20:57 INFO - Running setup.py install for mozscreenshot 18:20:57 INFO - Running setup.py install for moztest 18:20:57 INFO - Running setup.py install for mozversion 18:20:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:20:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:20:57 INFO - Cleaning up... 18:20:57 INFO - Return code: 0 18:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:57 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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:20:57 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 18:20:57 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 18:20:57 INFO - Using env: {'DISPLAY': ':0', 18:20:57 INFO - 'HOME': '/home/cltbld', 18:20:57 INFO - 'LANG': 'en_US.UTF-8', 18:20:57 INFO - 'LANGUAGE': 'en_US:en', 18:20:57 INFO - 'LOGNAME': 'cltbld', 18:20:57 INFO - 'MAIL': '/var/mail/cltbld', 18:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:57 INFO - 'MOZ_NO_REMOTE': '1', 18:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:57 INFO - 'NO_EM_RESTART': '1', 18:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:57 INFO - 'PWD': '/builds/slave/test', 18:20:57 INFO - 'SHELL': '/bin/bash', 18:20:57 INFO - 'SHLVL': '1', 18:20:57 INFO - 'TERM': 'linux', 18:20:57 INFO - 'TMOUT': '86400', 18:20:57 INFO - 'USER': 'cltbld', 18:20:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:57 INFO - '_': '/tools/buildbot/bin/python'} 18:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:57 INFO - Running setup.py (path:/tmp/pip-nK6QGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:57 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)) 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:57 INFO - Running setup.py (path:/tmp/pip-2w4KtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:57 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)) 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:57 INFO - Running setup.py (path:/tmp/pip-4X7QTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:57 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)) 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:57 INFO - Running setup.py (path:/tmp/pip-FgbHSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:57 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)) 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:58 INFO - Running setup.py (path:/tmp/pip-vPZubR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:58 INFO - Running setup.py (path:/tmp/pip-8Sa9zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:58 INFO - Running setup.py (path:/tmp/pip-vlsp6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:58 INFO - Running setup.py (path:/tmp/pip-odkoN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:58 INFO - Running setup.py (path:/tmp/pip-QWNblc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:58 INFO - Running setup.py (path:/tmp/pip-0nmIi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:58 INFO - Running setup.py (path:/tmp/pip-HeKwwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:58 INFO - Running setup.py (path:/tmp/pip-8ORDyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:58 INFO - Running setup.py (path:/tmp/pip-Rn_sMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:58 INFO - Running setup.py (path:/tmp/pip-dAh1sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:58 INFO - Running setup.py (path:/tmp/pip-Aj8gLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:58 INFO - Running setup.py (path:/tmp/pip-Zljd0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:58 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)) 18:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:58 INFO - Running setup.py (path:/tmp/pip-HIMlNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:58 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)) 18:20:58 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)) 18:20:58 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)) 18:20:58 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)) 18:20:58 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)) 18:20:58 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)) 18:20:58 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)) 18:20:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20: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 18:20: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 18:20: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 18:20: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 18:21:00 INFO - Downloading blessings-1.6.tar.gz 18:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:00 INFO - Installing collected packages: blessings 18:21:00 INFO - Running setup.py install for blessings 18:21:00 INFO - Successfully installed blessings 18:21:00 INFO - Cleaning up... 18:21:00 INFO - Return code: 0 18:21:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:00 INFO - Reading from file tmpfile_stdout 18:21:00 INFO - Current package versions: 18:21:00 INFO - argparse == 1.2.1 18:21:00 INFO - blessings == 1.6 18:21:00 INFO - blobuploader == 1.2.4 18:21:00 INFO - docopt == 0.6.1 18:21:00 INFO - functools32 == 3.2.3-2 18:21:00 INFO - jsonschema == 2.5.1 18:21:00 INFO - manifestparser == 1.1 18:21:00 INFO - mozInstall == 1.13 18:21:00 INFO - mozcrash == 1.0 18:21:00 INFO - mozdebug == 0.1 18:21:00 INFO - mozdevice == 0.51 18:21:00 INFO - mozfile == 1.2 18:21:00 INFO - mozhttpd == 0.7 18:21:00 INFO - mozinfo == 0.10 18:21:00 INFO - mozleak == 0.1 18:21:00 INFO - mozlog == 3.5 18:21:00 INFO - moznetwork == 0.27 18:21:00 INFO - mozprocess == 0.25 18:21:00 INFO - mozprofile == 0.28 18:21:00 INFO - mozrunner == 6.13 18:21:00 INFO - mozscreenshot == 0.1 18:21:00 INFO - mozsystemmonitor == 0.3 18:21:00 INFO - moztest == 0.8 18:21:00 INFO - mozversion == 1.4 18:21:00 INFO - psutil == 3.1.1 18:21:00 INFO - requests == 1.2.3 18:21:00 INFO - wsgiref == 0.1.2 18:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:00 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 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:21:00 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 18:21:00 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 18:21:00 INFO - Using env: {'DISPLAY': ':0', 18:21:00 INFO - 'HOME': '/home/cltbld', 18:21:00 INFO - 'LANG': 'en_US.UTF-8', 18:21:00 INFO - 'LANGUAGE': 'en_US:en', 18:21:00 INFO - 'LOGNAME': 'cltbld', 18:21:00 INFO - 'MAIL': '/var/mail/cltbld', 18:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:00 INFO - 'MOZ_NO_REMOTE': '1', 18:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:00 INFO - 'NO_EM_RESTART': '1', 18:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:00 INFO - 'PWD': '/builds/slave/test', 18:21:00 INFO - 'SHELL': '/bin/bash', 18:21:00 INFO - 'SHLVL': '1', 18:21:00 INFO - 'TERM': 'linux', 18:21:00 INFO - 'TMOUT': '86400', 18:21:00 INFO - 'USER': 'cltbld', 18:21:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:00 INFO - '_': '/tools/buildbot/bin/python'} 18:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 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)) 18:21:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:21:02 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)) 18:21:02 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)) 18:21:02 INFO - Installing collected packages: simplejson 18:21:02 INFO - Running setup.py install for simplejson 18:21:02 INFO - building 'simplejson._speedups' extension 18:21:02 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 18:21:03 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 18:21:03 INFO - Successfully installed simplejson 18:21:03 INFO - Cleaning up... 18:21:03 INFO - Return code: 0 18:21:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27329c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', '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 18:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:21:03 INFO - Using env: {'DISPLAY': ':0', 18:21:03 INFO - 'HOME': '/home/cltbld', 18:21:03 INFO - 'LANG': 'en_US.UTF-8', 18:21:03 INFO - 'LANGUAGE': 'en_US:en', 18:21:03 INFO - 'LOGNAME': 'cltbld', 18:21:03 INFO - 'MAIL': '/var/mail/cltbld', 18:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:03 INFO - 'MOZ_NO_REMOTE': '1', 18:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:03 INFO - 'NO_EM_RESTART': '1', 18:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:03 INFO - 'PWD': '/builds/slave/test', 18:21:03 INFO - 'SHELL': '/bin/bash', 18:21:03 INFO - 'SHLVL': '1', 18:21:03 INFO - 'TERM': 'linux', 18:21:03 INFO - 'TMOUT': '86400', 18:21:03 INFO - 'USER': 'cltbld', 18:21:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:03 INFO - '_': '/tools/buildbot/bin/python'} 18:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:21:04 INFO - Cleaning up... 18:21:04 INFO - Return code: 0 18:21:04 INFO - Running post-action listener: _resource_record_post_action 18:21:04 INFO - Running post-action listener: _start_resource_monitoring 18:21:04 INFO - Starting resource monitoring. 18:21:04 INFO - [mozharness: 2017-09-28 01:21:04.210257Z] Finished create-virtualenv step (success) 18:21:04 INFO - [mozharness: 2017-09-28 01:21:04.210772Z] Running install step. 18:21:04 INFO - Running pre-action listener: _resource_record_pre_action 18:21:04 INFO - Running main action method: install 18:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:04 INFO - Reading from file tmpfile_stdout 18:21:04 INFO - Detecting whether we're running mozinstall >=1.0... 18:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:21:04 INFO - Reading from file tmpfile_stdout 18:21:04 INFO - Output received: 18:21:04 INFO - Usage: mozinstall [options] installer 18:21:04 INFO - Options: 18:21:04 INFO - -h, --help show this help message and exit 18:21:04 INFO - -d DEST, --destination=DEST 18:21:04 INFO - Directory to install application into. [default: 18:21:04 INFO - "/builds/slave/test"] 18:21:04 INFO - --app=APP Application being installed. [default: firefox] 18:21:04 INFO - mkdir: /builds/slave/test/build/application 18:21:04 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'] 18:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:21:22 INFO - Reading from file tmpfile_stdout 18:21:22 INFO - Output received: 18:21:22 INFO - /builds/slave/test/build/application/firefox/firefox 18:21:22 INFO - Running post-action listener: _resource_record_post_action 18:21:22 INFO - [mozharness: 2017-09-28 01:21:22.172526Z] Finished install step (success) 18:21:22 INFO - [mozharness: 2017-09-28 01:21:22.172778Z] Running setup-mitmproxy step. 18:21:22 INFO - Running pre-action listener: _resource_record_pre_action 18:21:22 INFO - Running main action method: setup_mitmproxy 18:21:22 INFO - Skipping: mitmproxy is not required 18:21:22 INFO - Running post-action listener: _resource_record_post_action 18:21:22 INFO - [mozharness: 2017-09-28 01:21:22.173939Z] Finished setup-mitmproxy step (success) 18:21:22 INFO - [mozharness: 2017-09-28 01:21:22.174167Z] Running run-tests step. 18:21:22 INFO - Running pre-action listener: _resource_record_pre_action 18:21:22 INFO - Running pre-action listener: _set_gcov_prefix 18:21:22 INFO - Running main action method: run_tests 18:21:22 WARNING - Try message not found. 18:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:22 INFO - Python 2.7.3 18:21:22 INFO - Return code: 0 18:21:22 INFO - grabbing minidump binary from tooltool 18:21:22 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')]} 18:21:22 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 0x272fd60>, '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 0x2730a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:22 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 18:21:22 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 18:21:22 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 18:21:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:22 INFO - Return code: 0 18:21:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:21:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:22 INFO - ENV: RUST_BACKTRACE is now full 18:21:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:21:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:22 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/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 18:21:22 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/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 18:21:22 INFO - Using env: {'DISPLAY': ':0', 18:21:22 INFO - 'HOME': '/home/cltbld', 18:21:22 INFO - 'LANG': 'en_US.UTF-8', 18:21:22 INFO - 'LANGUAGE': 'en_US:en', 18:21:22 INFO - 'LOGNAME': 'cltbld', 18:21:22 INFO - 'MAIL': '/var/mail/cltbld', 18:21:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:22 INFO - 'MOZ_NO_REMOTE': '1', 18:21:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:22 INFO - 'NO_EM_RESTART': '1', 18:21:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:22 INFO - 'PWD': '/builds/slave/test', 18:21:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:22 INFO - 'RUST_BACKTRACE': 'full', 18:21:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:21:22 INFO - 'SHELL': '/bin/bash', 18:21:22 INFO - 'SHLVL': '1', 18:21:22 INFO - 'TERM': 'linux', 18:21:22 INFO - 'TMOUT': '86400', 18:21:22 INFO - 'USER': 'cltbld', 18:21:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:22 INFO - '_': '/tools/buildbot/bin/python'} 18:21:22 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/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 18:21:22 INFO - mozversion application_buildid: 20170927235256 18:21:22 INFO - mozversion application_changeset: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 18:21:22 INFO - mozversion application_display_name: Nightly 18:21:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:22 INFO - mozversion application_name: Firefox 18:21:22 INFO - mozversion application_remotingname: firefox 18:21:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:21:22 INFO - mozversion application_vendor: Mozilla 18:21:22 INFO - mozversion application_version: 58.0a1 18:21:22 INFO - mozversion platform_buildid: 20170927235256 18:21:22 INFO - mozversion platform_changeset: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 18:21:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:21:22 INFO - mozversion platform_version: 58.0a1 18:21:22 INFO - using testdate: 1506561682 18:21:22 INFO - actual date: 1506561682 18:21:22 INFO - starting webserver on 'localhost:37354' 18:21:22 INFO - SUITE-START | Running 2 tests 18:21:22 INFO - TEST-START | dromaeo_css 18:21:22 INFO - Initialising browser for dromaeo_css test... 18:21:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37354/getInfo.html -profile /tmp/tmpSsZeEx/profile 18:21:22 INFO - TEST-INFO | started process 15136 (/builds/slave/test/build/application/firefox/firefox http://localhost:37354/getInfo.html) 18:21:28 INFO - TEST-INFO | 15136: exit 0 18:21:28 INFO - Browser initialized. 18:21:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:21:28 INFO - Using env: {'DISPLAY': ':0', 18:21:28 INFO - 'HOME': '/home/cltbld', 18:21:28 INFO - 'JSGC_DISABLE_POISONING': '1', 18:21:28 INFO - 'LANG': 'en_US.UTF-8', 18:21:28 INFO - 'LANGUAGE': 'en_US:en', 18:21:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:21:28 INFO - 'LOGNAME': 'cltbld', 18:21:28 INFO - 'MAIL': '/var/mail/cltbld', 18:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:28 INFO - 'MOZ_CRASHREPORTER': '1', 18:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:21:28 INFO - 'MOZ_NO_REMOTE': '1', 18:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:28 INFO - 'NO_EM_RESTART': '1', 18:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:28 INFO - 'PWD': '/builds/slave/test', 18:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:28 INFO - 'RUST_BACKTRACE': 'full', 18:21:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:21:28 INFO - 'SHELL': '/bin/bash', 18:21:28 INFO - 'SHLVL': '1', 18:21:28 INFO - 'STYLO_FORCE_DISABLED': '1', 18:21:28 INFO - 'TERM': 'linux', 18:21:28 INFO - 'TMOUT': '86400', 18:21:28 INFO - 'USER': 'cltbld', 18:21:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:28 INFO - '_': '/tools/buildbot/bin/python'} 18:21:28 INFO - TEST-INFO | started process 15373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSsZeEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:29 INFO - PID 15373 | 18:21:29 INFO - PID 15373 | (/builds/slave/test/build/application/firefox/firefox:15422): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:21:29 INFO - PID 15373 | 18:21:39 INFO - PID 15373 | RSS: Main: 144674816 18:21:39 INFO - PID 15373 | 18:24:36 INFO - PID 15373 | Cycle 1(1): loaded http://localhost:37354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37354/tests/dromaeo/cssquery-ext.html) 18:24:37 INFO - PID 15373 | RSS: Main: 143003648 18:24:37 INFO - PID 15373 | 18:27:39 INFO - PID 15373 | Cycle 1(1): loaded http://localhost:37354/tests/dromaeo/cssquery-ext.html (next: http://localhost:37354/tests/dromaeo/cssquery-jquery.html) 18:27:40 INFO - PID 15373 | RSS: Main: 143683584 18:27:40 INFO - PID 15373 | 18:30:41 INFO - PID 15373 | Cycle 1(1): loaded http://localhost:37354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37354/tests/dromaeo/cssquery-mootools.html) 18:30:42 INFO - PID 15373 | RSS: Main: 145055744 18:30:42 INFO - PID 15373 | 18:33:43 INFO - PID 15373 | Cycle 1(1): loaded http://localhost:37354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37354/tests/dromaeo/cssquery-prototype.html) 18:33:44 INFO - PID 15373 | RSS: Main: 144130048 18:33:44 INFO - PID 15373 | 18:36:47 INFO - PID 15373 | Cycle 1(1): loaded http://localhost:37354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37354/tests/dromaeo/cssquery-yui.html) 18:36:48 INFO - PID 15373 | RSS: Main: 147939328 18:36:48 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | Cycle 1(1): loaded http://localhost:37354/tests/dromaeo/cssquery-yui.html (next: http://localhost:37354/tests/dromaeo/cssquery-dojo.html) 18:39:49 INFO - PID 15373 | RSS: Main: 148631552 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | __start_tp_report 18:39:49 INFO - PID 15373 | _x_x_mozilla_page_load 18:39:49 INFO - PID 15373 | _x_x_mozilla_page_load_details 18:39:49 INFO - PID 15373 | |i|pagename|runs| 18:39:49 INFO - PID 15373 | |0;dojo.html;3799.924001519969;3818.7517811342277;3823.827927743251;3850.8459661613538;3855.0169706724782;6102.145699602059;6115.908261376083;6180.536459765519;6206.534509911758;6234.968825155874;6218.129461875341;6250.9062364064575;6258.62448253104;6261.906071408933;6299.023651334051;5619.662820230778;5682.204491371212;5714.771409143629;5729;5742.339630942453;5675.631083979549;5680.943190568103;5742.454466825666;5768.077107662775;5778.0466223073145;5502.8349149525575;5610.663360198401;5618.550515958714;5650.886982260352;5695.886082278331;5619.915701264485;5651.547876169897;5667.886642267173;5687.061634830248;5707.828765137011;5551.944480555224;5567.276254086943;5607.887842243133;5678.971605141989;5695.088785794253;6233.563650544464;6234.0960560718895;6250.093736408241;6259.968700156515;6298.527610429191;6736.8989465158065;6762.425193858528;6824.078749368821;6839.521233513656;6840.281770414084;6702.597844129319;6750.088738020353;6795.38841504262;6810;6879.105716256855;6248.4688801451475;6258.624482531062;6264.843378915518;6303.842403939892;6392.137061496638;6922.965385173143;6991.720331186797;6999.860002800017;7000.054992576039;7004;6559.639219842859;6675.432588229958;6693.732250710014;6732.023856540774;6772.5936443813525;6783.18601767791;6830.795076147723;6863.245043045261;6864;6901.930980690229;6725.428338591275;6758.695858686371;6791.456683465311;6819.965900170468;6820.624865632339;6718;6744.359285867835;6753.189617245962;6753.257141714505;6854.383105520527;4933.531314525115;4978.178600530872;4983.103041452573;5017.222330538772;5054.16606259963;4491.595756381941;4547.47704014036;4556.726596404226;4568.543145685471;4610.469795973506;6222.968885155636;6242.563020588606;6290.937090629127;6295.905561416583;6315.210598675166;6649.73401063952;6709.060731497594;6756.763513277012;6760.222574403908;6770.93229067703;6122.234720659918;6186.4741496972365;6253.593516421418;6284.4344009039405;6301.40136687014;5412.972935135299;5488.423715509894;5498.230247765316;5502.284702988586;5504.834854954358;6871.484638652121;6911.827204319932;6954;6978.092847929838;7016.5790052597;6672.899906501503;6686;6717;6717.2946840581035;6735.6968936397;6928.341807528277;7004.089468369283;7038.542494737826;7071.328223818729;7096.574205547684;6708.966455167693;6755.121834161528;6792.150981127359;6817.522773406013;6826.453883689193;6689.966550167218;6741.325867413219;6749.696263668048;6845.418139458003;6849.1780986281965;6507.902381464187;6521.510886683613;6574;6581;6581;6253.468455181179;6547.803565893031;6553.934460655332;6565.113709649137;6569.4744420445295;6391.360863913572;6416.711247993758;6449.322821103717;6506.381893720279;6546.116274302908;6493.837654058686;6547.70535325921;6568.080468734285;6658.966705166443;6661.267260601427;6387.936120638734;6450.54846160783;6463.450606698483;6466.256380516113;6472.773452929125 18:39:49 INFO - PID 15373 | |1;ext.html;912.8950170730368;913.0641092879802;924.6624981881614;957.1433566957573;962.8700125483058;44074.77962610187;44550.55449445505;44707.77646111769;44779.10441791162;44843.32735008969;41949;42208.78895605525;42285.36571951416;42343.78828105855;42387.364189537104;7401.962990185041;7511.849763004737;7523.4357423193205;7558.35753960914;7585.013948186755;7456.328930396263;7506.399488040944;7561.979132817082;7566.129895062056;7573.810654733648;7540.2082781308;8311.418200725951;8486.702965396213;8517.23344898959;8548.230659240668;8422.663093476254;8494.447860889084;8497.107803680587;8497.320214382866;8497.915020849805;8156.2659360657235;8333.250007499293;8431.241188293021;8442.915570844274;8444.493330400195;41009.179816403805;41229.1754164918;41240.793796030826;41294.38058429126;41337.79331103355;3656.2504686539196;3667.94498082529;3691.2986532559;3692.9659695285363;3695.0392897846486;33745.325093497995;33977.15057123567;34018.6598134018;34034.149146271295;34038.14904627379;5449.1826226066405;5461.5357694596005;5505.201745746845;5553.305836770403;5555.861103472405;221539;222423;222921;223645.99999999837;223713;53897.1915421269;53937;54013;54050.45949540533;54130.45869541254;55528.44471555314;55857.720711396185;55914.72042639761;56065.43934560602;56099.71950140223;17129.14354282281;17402.65194696099;17406.129693515275;17437.47687569375;17536.035518046374;14330.140191588538;14396.784048239284;14425.350859211361;14441.422343106158;14446.855531444551;14613.78079328811;14746.18895960711;14802.333894974752;14828.481003165054;15019.173945432887;5749.660364964567;5773.740181691834;5821.825345239649;5933.970330148321;5986.760529578855;1086.2396322574073;1097.9121670266359;1097.983530247047;1099.0712847643729;1117.6591139702468;25637.3590660235;26011;26112.216633501026;26189.476210475685;26305.868470657526;1193.5524178433088;1205.9809461005436;1206.5354838387284;1230.926144431319;1238.6717519857245;13506.729865402636;13546.119502232323;13624.250666213255;13721.108127971649;13984;294137;295594;296054;296809;297061;53855.73072134614;64114;65282.347176527626;65520.34479655143;65614;1533.0418488444723;1540.2991638804317;1547.7678348247853;1554.1063888264518;1572.5989872582418;30407;30897.227569310948;31095.222619434695;31149.221269468446;31233.219169520944;42514.78742606267;42749.572504275806;42828.57171428246;42908.57091429046;42910.141797164506;241895;242584;242694;242831;243504;34793.304133917685;35638.8218058908;35854.82072589621;35863;36071;46552.301715474976;46847.53152468432;47338.05323893572;47588;47617;34177.31645367129;34544;34806.30387392289;34990;35281.47077793886;34421.483677744356;34823.30353392867;34872.30255394827;34905;35458.468122978695;40539.594604053585;41371.379429307985;41416;41819;41848.58151418569;33385;33884.830575846965;34113.65886341204;34143.82928085443;34605.30789384249;25005.74994250034;25193.748062519142;25300.873495632404;25688;25938.610920835825 18:39:49 INFO - PID 15373 | |2;jquery.html;629.0361959107861;636.0855084811401;639.6205047947235;644.0418774261851;649.8797722421356;23155.884220578893;23608.173713920016;24125.15561955332;24194.75805241947;24926.626100608504;27360.315992100208;27640.308992275204;27662.170134895987;27696.584551231746;27699.723002769966;6594;6658.234303055138;6812.4550035997245;6818.9659051704675;6829.078074459959;6831.180258369002;6858.588484690935;6865.862682746342;6881.552699074544;6887.7244910203535;6794.898076528856;6827.249002609709;6839.1451068616425;6840.28177041411;6850.109485766843;6840.692168852389;6843.931560684404;6846.383825455733;6846.554973926679;6854.177498700163;6400;6400.135981642466;6414.4227019568;6415;6415.679216039226;29460.705392946224;31678.208044799063;31873.681263187536;31904.840475797704;31968.520472192937;2225.554889022202;2235.508188198594;2235.5417139486367;2238.2278114050628;2241.2267767620147;20473.692894606593;20555.48611284715;20924.581508369898;21321.893390533103;21345.786542134534;2602.414456747236;2621.3839747659285;2638.511875303075;2645.9867700661375;2656.8273062251087;135051;141020.29489852587;141535;154472;160709.16099614516;16294.918525407535;16697.580705639914;16850.241739121768;17073.829261707473;17141.914290428467;27395.178144655692;27490.17529474119;27581.724182758317;27610.723892761216;27641.447171056465;10822.350658960488;10874.184436167161;11143.944280278709;11181.540061186526;11188.720281992852;10092.596296148218;10138.746531336776;10187.694369168938;10207.591696332212;10276.126529244948;9874.753131171778;9875.209983201326;9981.101700846959;10047.547860346156;10348.275620706478;2889.812162209492;2899.7390234878962;2959.837208953485;2974.732274095342;3031.6968303169506;1032.4218437674926;1036.3522798251092;1041.2763129624839;1044.216837371971;1045.3466583385384;21318.360449186548;21497.247596334368;21687.67468487974;21698.34904952854;21736.782632173792;1090.2150451674781;1104.5140138339104;1105.5798796457295;1110.9611163609236;1121.8261169518737;11718.179727419169;11759.235649682743;11781.882181178249;11958.043356531456;12021.398930053463;587905;592246.038769812;596616;600974;606014;133187.33406332906;133644;134309.32845335905;134456;134726.32636836948;1067.9679609611724;1245.800671892511;1269;1286.0290480687208;1294.0294778915813;21545.89227053855;22237.77762222357;22465.43836404103;22563.77436225617;22948.082076716746;61743.6912815433;62334.37665623286;63329.68335158479;63838.68080659567;64932.67533662301;82175.17824821915;82641.17358826335;82896.58551707203;83148;83508;21283.36149915505;21854.235101771363;21969;22014.779852201274;22018.779812202312;23724;24454.87772561126;24511.877440612683;24600.261992140266;24609.753902460747;19832;20167.69748453745;20188.495287617927;20405.59188816245;20421.285255016002;17920.551986200448;18152;18403.63192736111;18546.350877719215;18719.90640046791;19813;20448.79551204469;20451.181952721723;20545.89727051415;20646.17415303371;21247.78752212458;21349.89325053365;21358.145674172858;21459.785402146405;21514.247001354877;19612.803871961667;19783.208671652974;19841.30555430553;19859.404217873485;19882.90058549698 18:39:49 INFO - PID 15373 | |3;mootools.html;1392.1647011792923;1438.5180964376934;1447.8334991475976;1453.215263757571;1457.1839769728952;17260.91369543152;17948.55128621785;17970.281188752433;17973.101344932766;18024.188911498964;17608.383706570272;17773.022483763387;17803.73294400585;17818.64362712745;17831;2743.5198840202984;2873.1524200360946;2881.2076678913363;2893.4213157368504;2895.55118956561;2567.9101231456902;2697.9190624281305;2701.8784154712985;2702.216357256393;2704.283364908301;2724.577690457982;2915.7375836174847;2923.342247994195;2928.2386579489275;2928.3704003639214;2568.268043607572;2592.857392843393;2615.777658898996;2616.5551856184493;2620.4104076582807;2634.2229042432527;2655.8804853781626;2669.439417722261;2685.207863680219;2691.932701682454;15779.763303550455;16049.91975040129;16090.839091609168;16109.516714498584;16114.11372374519;8646.394752367336;8930.86603700945;8933.6873209438;8939.240164586017;8947.239484643747;5594.1888426177975;5682.40334764852;5715.885682286373;5832.300123985149;5899.233099697055;2109.7671844736815;2132.4349047502424;2139.1229595865775;2165.350394881545;2172.3700126963163;32754.181145471317;32868;33122.6687733122;33616.49575256373;33682.99999999975;7279.854402911912;7389.150247721581;7440.3675687567165;7468.141163766237;7513.849723005509;20838.479038023866;20860.791392085885;20880.79119208819;20883.37349879506;20898.686519702216;8538.146185381413;8558.186972237627;8633.827323453495;8651.6971905983;8666.176713212235;7860.371170306362;7879.724209652749;7985.560794156378;7999.240072193249;8062;5510.972445137829;5671.319441667027;5672.517835983905;5723.998300297431;5726.856828579319;1693.6443346897042;1736.1319340329835;1747.2923465996291;1766.646670665872;1771.7076682347526;979.8383266761048;985.5072463768116;999.0658734083655;1014.1227837920146;1018.256672628985;8642.898446690959;8652.394332396672;8802.987656419466;8842.91157088421;8992.46045237288;718.9784306470814;743.108270075911;751.2374939436368;759.787259567322;762.954222746637;5416.268803711528;5454.7272636368025;6118.20463339763;6173.783917562953;6347.52393570484;25102.372440688763;25926.481470370487;26168.214953551425;26513.204603861916;26850.865745671148;25363.98544058217;25684.614730779052;26185.34536636561;26386.94452221928;26425.86787066091;10775.676729698122;11123.55505779776;12562.309073001255;13090.738185236241;13315.800262996063;9685.273604479551;9712.465814380277;9789.118979291898;9899.257555683209;9991.450470223917;20637;20847.791522084586;21258.36224913255;21683.891580542626;22056.228032018804;22375.664365034212;22407.77592224122;22482;22567.32298031062;22761.658575121055;11960.820587691365;12115.454804533641;12188.939055304667;12209.69475763113;12233.632991010283;15486.612834678772;15498.690026199638;15567.532974010797;15594.610134746723;15629.531114066596;11808.291502509877;12536.247825130522;12547.560835370718;12575.748485030432;12588.622341329774;11645.184837061324;12073.57742479009;12305.630831075083;12623.621291361274;12686.555970540987;10703.19726020536;10962.561497540328;10975.725606859893;10981.835272471078;10984.286021408583;8644.697435589724;8673.349498787742;8746.65013399457;8816.735497935073;8839.16027977341;8292.502449853027;8306.210909963544;8317.95841020791;8335.291500222307;8361.414700971118 18:39:49 INFO - PID 15373 | |4;prototype.html;549.4423160492101;550.1500182218477;550.2379204801349;560.1653536231016;581.2792137749192;6225.937740622592;6270.028145637428;6297.275813281468;6299.527535434843;6381.712822922968;6243.71903264353;6286.748530058792;6287.1198032275515;6350.777722779703;6365.904511432333;4951.727654978975;5134.409542902558;5201.401838788531;5208.973955130219;5216.530512253897;5006;5010.974945125269;5016.423111342206;5049.899002019957;5050.131451363;4960.131976904046;4962.702237865721;4988.575971042465;5026.29631851541;5041.395032596093;4987.925181122286;5003.199488081926;5003.399592048941;5016.122178618727;5053.722045287508;4559.6124329431705;4578.2903649934315;4588.977055114737;4603.217453032959;4609.516000819933;6250.718717657716;6270.874582508324;6301.6534090625;6315.621062736251;6354.459870910978;5803.446483547225;5819.330776960662;5827.912581311241;5871.9412805871825;5957.404259574051;6629.839778038824;6656.3691895485435;6697.6986035628515;6700.363465470772;6748.527603067787;5110.437851836295;5141.203113517411;5147.6654017488745;5151.7681704323395;5193.662411943249;6996.772872143796;7028.753993610199;7061.258567850353;7117.964410177968;7118.572885626827;5200.76596553156;5269.762860671279;5292.5501332387175;5295.947040529622;5333.786648534093;5407.107827208467;5409.783608655688;5419.214213938957;5423.728813559306;5428.2671839301975;5829.446202610745;5877.589378549203;5909.527237820964;5914.64512129265;5925.822225333247;6305.801897639434;6540.967295163494;6595.901061484082;6622.602643841385;6775.322467753185;1833.2208811255164;1842.6222624362242;1856.3595559531939;1862.981370186308;1865.6753704869423;1249.4689756853484;1304.2630913534013;1315.960521184366;1337.0106121470042;1338.1569611144917;6172.753089876354;6200.534959878028;6212.161358216673;6255.186825712719;6269.8746025079245;6714.395704386531;6809.421199198025;6823.112995310578;6840.31596840312;6887.724491020404;6241.7191226394925;6268.1851359323;6302.684865756693;6360.395762402564;6378.489720822323;3554.7689400188906;3606.891793246207;3607.7294202934886;3611.566612006576;3654.780713157219;7052.858942821114;7088.858222835514;7100.183478899992;7103.644817759091;7161.5676864627285;7021.964890175618;7050.259722729143;7078.858422831618;7100.9289907100265;7105.147382314155;7018.719251229996;7067.222605513492;7089.539179953286;7147.499675022803;7207.45944054198;6798.354156355138;6871.415929646036;6896.862062758817;6920.342567456084;6958.582485050913;6296.338884417253;6715.932840671726;6740.561863478858;6777.864442711217;6797.422219111233;6767.492438067263;6834.557537600599;6888.965555172192;6891.896621550581;6995.230524642387;5114.181730923035;5219.869503262449;5250.527452529291;5253.317068781034;5274.525292723673;6508.511861610304;6517.348265173445;6634.042957327696;6885.758998435031;6974.860502790018;6480.116348224995;6556.868862622816;6586.8353291168105;6619.966900165661;6627.502937279627;6585.473162147113;6589.571677840925;6602.966985165043;6602.966985165235;6674.265830758515;6416.743330266737;6554.377334153248;6560.212774467094;6564.868702626016;6627.403533681992;6629.834254143685;6637.8383782836845;6687;6745.628990405378;6776.28848970851;6432.453241474527;6438.935610643834;6467.15926929515;6471.320511346429;6530.281669016499 18:39:49 INFO - PID 15373 | |5;yui.html;952.2049089010676;959.8080383923215;988.5551501824176;992.5483904823307;999.8600195972565;19677;20239.898800506013;20248.59502809943;20310.289139880108;20320.796792032095;19067.332643357484;19544.51138721529;19580.902095489502;19732.40802775919;19806;1022.9488525573729;1035.9847349597399;1040.032769524342;1040.9427481488515;1041.8801837788637;1010.9696709098702;1043.9530221140028;1052.7420781908404;1055.408970976252;1056.023178559833;1130.2314426190187;1130.8416821644976;1132.1169487799489;1132.224426268009;1136.551062330379;1119.641714651312;1123.084685980923;1126.8084425647578;1129.305477131558;1133.529585222136;823.7611092783086;829.5810615639124;833.1668331668332;834.5952213176605;838.5429940682343;18119.818801811944;20010;20032.29886953964;20274.89862550678;20279;22284.220052298253;22562.307826913046;22670.319890403316;22674.206402775824;22678.77321226783;18255.178516966636;18595.721064183912;18633.906830465898;18644.161012754324;18654.720179197324;3834.5973672764517;3987.2623564640344;4000.3399439092514;4025.838966441339;4040.6363427291685;152350;162353.9999999988;164560;165221;165996;18815.529611759543;18881.339153129575;19001.334953276844;19065.04674766256;19126.71309930352;34056.48915266273;34721.826390867885;34922.650773492445;35012.82493587516;35081.64918350784;9379.48412837287;9690.51547422626;9693.273004524688;10016.29885907994;10054.245931555162;4575.450945886515;4622.260438329851;4632.374629424984;4634.46703629087;4659.976700116477;5914.615549989237;6007.30915944672;6007.639541627516;6011.977963746086;6141.6007959482495;1159.084323384517;1170.2042611024585;1194.6296648039136;1196.874328195527;1198.5924785572772;710.4210068793916;722.2705067881373;741.8738814401564;747.872861613527;749.0300061420473;12100.636980890587;12486.063545233963;12704.36478176106;13289.667758305926;13421.932890335485;689.5449003657562;703.3529153179087;714.8927660850914;716.3660160757663;718.4432065149551;5948.524118070544;6000.579959402888;6064.696765161812;6078.361772013964;6106.236720409949;162669;163866;164155;164922;167633;117819;135000.3249983744;135100.32449837687;140232;149573;121673;121844;122046;124334.75665243412;125599.3720031394;13229.669258268621;13591.184528928296;13653.658658533219;13677.179369237878;13853.168809871037;56849.715751420976;57795.71102144462;58095;58810.41189588221;59200.703996479744;74670.2532974685;75285.62357188179;76066.61966690132;76302.61848690722;78236.60881695554;18427.723584146515;18458.169382377557;18714;18869.622607548048;18902.054897254806;21226.681599776326;21554;21703.131874724833;21877.234296799536;22069.33791986243;19465.318713844947;19771.703424448933;19984.20063197456;19991.700124498435;20125.094370753643;19502.90248548748;19506.219751209792;19512.512187195432;19914;20151.496212594804;17850.464486065437;17975.191116399532;18264.08679566043;18341.541461463035;18368.724469132707;14259.572212833631;14672.853271467575;14681.119132852064;14892.702145957237;14908.478203262834;13961.720765584834;14029.01796874209;14144.858551414354;14180.858191418367;14209.715805684034 18:39:49 INFO - PID 15373 | __end_tp_report 18:39:49 INFO - PID 15373 | __start_cc_report 18:39:49 INFO - PID 15373 | _x_x_mozilla_cycle_collect,265 18:39:49 INFO - PID 15373 | __end_cc_report 18:39:49 INFO - PID 15373 | __startTimestamp1506562789974__endTimestamp 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | ------- Summary: start ------- 18:39:49 INFO - PID 15373 | Number of tests: 6 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | [#0] dojo.html Cycles:165 Average:6237.36 Median:6466.26 stddev:727.70 (11.3%) stddev-sans-first:704.36 18:39:49 INFO - PID 15373 | Values: 3799.9 3818.8 3823.8 3850.8 3855.0 6102.1 6115.9 6180.5 6206.5 6235.0 6218.1 6250.9 6258.6 6261.9 6299.0 5619.7 5682.2 5714.8 5729.0 5742.3 5675.6 5680.9 5742.5 5768.1 5778.0 5502.8 5610.7 5618.6 5650.9 5695.9 5619.9 5651.5 5667.9 5687.1 5707.8 5551.9 5567.3 5607.9 5679.0 5695.1 6233.6 6234.1 6250.1 6260.0 6298.5 6736.9 6762.4 6824.1 6839.5 6840.3 6702.6 6750.1 6795.4 6810.0 6879.1 6248.5 6258.6 6264.8 6303.8 6392.1 6923.0 6991.7 6999.9 7000.1 7004.0 6559.6 6675.4 6693.7 6732.0 6772.6 6783.2 6830.8 6863.2 6864.0 6901.9 6725.4 6758.7 6791.5 6820.0 6820.6 6718.0 6744.4 6753.2 6753.3 6854.4 4933.5 4978.2 4983.1 5017.2 5054.2 4491.6 4547.5 4556.7 4568.5 4610.5 6223.0 6242.6 6290.9 6295.9 6315.2 6649.7 6709.1 6756.8 6760.2 6770.9 6122.2 6186.5 6253.6 6284.4 6301.4 5413.0 5488.4 5498.2 5502.3 5504.8 6871.5 6911.8 6954.0 6978.1 7016.6 6672.9 6686.0 6717.0 6717.3 6735.7 6928.3 7004.1 7038.5 7071.3 7096.6 6709.0 6755.1 6792.2 6817.5 6826.5 6690.0 6741.3 6749.7 6845.4 6849.2 6507.9 6521.5 6574.0 6581.0 6581.0 6253.5 6547.8 6553.9 6565.1 6569.5 6391.4 6416.7 6449.3 6506.4 6546.1 6493.8 6547.7 6568.1 6659.0 6661.3 6387.9 6450.5 6463.5 6466.3 6472.8 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | [#1] ext.html Cycles:180 Average:43602.14 Median:3662.10 stddev:66554.27 (1817.4%) stddev-sans-first:66663.79 18:39:49 INFO - PID 15373 | Values: 912.9 913.1 924.7 957.1 962.9 44074.8 44550.6 44707.8 44779.1 44843.3 41949.0 42208.8 42285.4 42343.8 42387.4 7402.0 7511.8 7523.4 7558.4 7585.0 7456.3 7506.4 7562.0 7566.1 7573.8 7540.2 8311.4 8486.7 8517.2 8548.2 8422.7 8494.4 8497.1 8497.3 8497.9 8156.3 8333.3 8431.2 8442.9 8444.5 41009.2 41229.2 41240.8 41294.4 41337.8 3656.3 3667.9 3691.3 3693.0 3695.0 33745.3 33977.2 34018.7 34034.1 34038.1 5449.2 5461.5 5505.2 5553.3 5555.9 221539.0 222423.0 222921.0 223646.0 223713.0 53897.2 53937.0 54013.0 54050.5 54130.5 55528.4 55857.7 55914.7 56065.4 56099.7 17129.1 17402.7 17406.1 17437.5 17536.0 14330.1 14396.8 14425.4 14441.4 14446.9 14613.8 14746.2 14802.3 14828.5 15019.2 5749.7 5773.7 5821.8 5934.0 5986.8 1086.2 1097.9 1098.0 1099.1 1117.7 25637.4 26011.0 26112.2 26189.5 26305.9 1193.6 1206.0 1206.5 1230.9 1238.7 13506.7 13546.1 13624.3 13721.1 13984.0 294137.0 295594.0 296054.0 296809.0 297061.0 53855.7 64114.0 65282.3 65520.3 65614.0 1533.0 1540.3 1547.8 1554.1 1572.6 30407.0 30897.2 31095.2 31149.2 31233.2 42514.8 42749.6 42828.6 42908.6 42910.1 241895.0 242584.0 242694.0 242831.0 243504.0 34793.3 35638.8 35854.8 35863.0 36071.0 46552.3 46847.5 47338.1 47588.0 47617.0 34177.3 34544.0 34806.3 34990.0 35281.5 34421.5 34823.3 34872.3 34905.0 35458.5 40539.6 41371.4 41416.0 41819.0 41848.6 33385.0 33884.8 34113.7 34143.8 34605.3 25005.7 25193.7 25300.9 25688.0 25938.6 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | [#2] jquery.html Cycles:180 Average:40295.65 Median:2235.52 stddev:99815.16 (4465.0%) stddev-sans-first:100050.74 18:39:49 INFO - PID 15373 | Values: 629.0 636.1 639.6 644.0 649.9 23155.9 23608.2 24125.2 24194.8 24926.6 27360.3 27640.3 27662.2 27696.6 27699.7 6594.0 6658.2 6812.5 6819.0 6829.1 6831.2 6858.6 6865.9 6881.6 6887.7 6794.9 6827.2 6839.1 6840.3 6850.1 6840.7 6843.9 6846.4 6846.6 6854.2 6400.0 6400.1 6414.4 6415.0 6415.7 29460.7 31678.2 31873.7 31904.8 31968.5 2225.6 2235.5 2235.5 2238.2 2241.2 20473.7 20555.5 20924.6 21321.9 21345.8 2602.4 2621.4 2638.5 2646.0 2656.8 135051.0 141020.3 141535.0 154472.0 160709.2 16294.9 16697.6 16850.2 17073.8 17141.9 27395.2 27490.2 27581.7 27610.7 27641.4 10822.4 10874.2 11143.9 11181.5 11188.7 10092.6 10138.7 10187.7 10207.6 10276.1 9874.8 9875.2 9981.1 10047.5 10348.3 2889.8 2899.7 2959.8 2974.7 3031.7 1032.4 1036.4 1041.3 1044.2 1045.3 21318.4 21497.2 21687.7 21698.3 21736.8 1090.2 1104.5 1105.6 1111.0 1121.8 11718.2 11759.2 11781.9 11958.0 12021.4 587905.0 592246.0 596616.0 600974.0 606014.0 133187.3 133644.0 134309.3 134456.0 134726.3 1068.0 1245.8 1269.0 1286.0 1294.0 21545.9 22237.8 22465.4 22563.8 22948.1 61743.7 62334.4 63329.7 63838.7 64932.7 82175.2 82641.2 82896.6 83148.0 83508.0 21283.4 21854.2 21969.0 22014.8 22018.8 23724.0 24454.9 24511.9 24600.3 24609.8 19832.0 20167.7 20188.5 20405.6 20421.3 17920.6 18152.0 18403.6 18546.4 18719.9 19813.0 20448.8 20451.2 20545.9 20646.2 21247.8 21349.9 21358.1 21459.8 21514.2 19612.8 19783.2 19841.3 19859.4 19882.9 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | [#3] mootools.html Cycles:180 Average:10658.87 Median:26406.41 stddev:8121.71 (30.8%) stddev-sans-first:8114.66 18:39:49 INFO - PID 15373 | Values: 1392.2 1438.5 1447.8 1453.2 1457.2 17260.9 17948.6 17970.3 17973.1 18024.2 17608.4 17773.0 17803.7 17818.6 17831.0 2743.5 2873.2 2881.2 2893.4 2895.6 2567.9 2697.9 2701.9 2702.2 2704.3 2724.6 2915.7 2923.3 2928.2 2928.4 2568.3 2592.9 2615.8 2616.6 2620.4 2634.2 2655.9 2669.4 2685.2 2691.9 15779.8 16049.9 16090.8 16109.5 16114.1 8646.4 8930.9 8933.7 8939.2 8947.2 5594.2 5682.4 5715.9 5832.3 5899.2 2109.8 2132.4 2139.1 2165.4 2172.4 32754.2 32868.0 33122.7 33616.5 33683.0 7279.9 7389.2 7440.4 7468.1 7513.8 20838.5 20860.8 20880.8 20883.4 20898.7 8538.1 8558.2 8633.8 8651.7 8666.2 7860.4 7879.7 7985.6 7999.2 8062.0 5511.0 5671.3 5672.5 5724.0 5726.9 1693.6 1736.1 1747.3 1766.6 1771.7 979.8 985.5 999.1 1014.1 1018.3 8642.9 8652.4 8803.0 8842.9 8992.5 719.0 743.1 751.2 759.8 763.0 5416.3 5454.7 6118.2 6173.8 6347.5 25102.4 25926.5 26168.2 26513.2 26850.9 25364.0 25684.6 26185.3 26386.9 26425.9 10775.7 11123.6 12562.3 13090.7 13315.8 9685.3 9712.5 9789.1 9899.3 9991.5 20637.0 20847.8 21258.4 21683.9 22056.2 22375.7 22407.8 22482.0 22567.3 22761.7 11960.8 12115.5 12188.9 12209.7 12233.6 15486.6 15498.7 15567.5 15594.6 15629.5 11808.3 12536.2 12547.6 12575.7 12588.6 11645.2 12073.6 12305.6 12623.6 12686.6 10703.2 10962.6 10975.7 10981.8 10984.3 8644.7 8673.3 8746.7 8816.7 8839.2 8292.5 8306.2 8318.0 8335.3 8361.4 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | [#4] prototype.html Cycles:180 Average:5688.37 Median:6298.40 stddev:1584.57 (25.2%) stddev-sans-first:1541.35 18:39:49 INFO - PID 15373 | Values: 549.4 550.2 550.2 560.2 581.3 6225.9 6270.0 6297.3 6299.5 6381.7 6243.7 6286.7 6287.1 6350.8 6365.9 4951.7 5134.4 5201.4 5209.0 5216.5 5006.0 5011.0 5016.4 5049.9 5050.1 4960.1 4962.7 4988.6 5026.3 5041.4 4987.9 5003.2 5003.4 5016.1 5053.7 4559.6 4578.3 4589.0 4603.2 4609.5 6250.7 6270.9 6301.7 6315.6 6354.5 5803.4 5819.3 5827.9 5871.9 5957.4 6629.8 6656.4 6697.7 6700.4 6748.5 5110.4 5141.2 5147.7 5151.8 5193.7 6996.8 7028.8 7061.3 7118.0 7118.6 5200.8 5269.8 5292.6 5295.9 5333.8 5407.1 5409.8 5419.2 5423.7 5428.3 5829.4 5877.6 5909.5 5914.6 5925.8 6305.8 6541.0 6595.9 6622.6 6775.3 1833.2 1842.6 1856.4 1863.0 1865.7 1249.5 1304.3 1316.0 1337.0 1338.2 6172.8 6200.5 6212.2 6255.2 6269.9 6714.4 6809.4 6823.1 6840.3 6887.7 6241.7 6268.2 6302.7 6360.4 6378.5 3554.8 3606.9 3607.7 3611.6 3654.8 7052.9 7088.9 7100.2 7103.6 7161.6 7022.0 7050.3 7078.9 7100.9 7105.1 7018.7 7067.2 7089.5 7147.5 7207.5 6798.4 6871.4 6896.9 6920.3 6958.6 6296.3 6715.9 6740.6 6777.9 6797.4 6767.5 6834.6 6889.0 6891.9 6995.2 5114.2 5219.9 5250.5 5253.3 5274.5 6508.5 6517.3 6634.0 6885.8 6974.9 6480.1 6556.9 6586.8 6620.0 6627.5 6585.5 6589.6 6603.0 6603.0 6674.3 6416.7 6554.4 6560.2 6564.9 6627.4 6629.8 6637.8 6687.0 6745.6 6776.3 6432.5 6438.9 6467.2 6471.3 6530.3 18:39:49 INFO - PID 15373 | 18:39:49 INFO - PID 15373 | [#5] yui.html Cycles:180 Average:29624.05 Median:19504.56 stddev:44578.47 (228.6%) stddev-sans-first:44651.54 18:39:49 INFO - PID 15373 | Values: 952.2 959.8 988.6 992.5 999.9 19677.0 20239.9 20248.6 20310.3 20320.8 19067.3 19544.5 19580.9 19732.4 19806.0 1022.9 1036.0 1040.0 1040.9 1041.9 1011.0 1044.0 1052.7 1055.4 1056.0 1130.2 1130.8 1132.1 1132.2 1136.6 1119.6 1123.1 1126.8 1129.3 1133.5 823.8 829.6 833.2 834.6 838.5 18119.8 20010.0 20032.3 20274.9 20279.0 22284.2 22562.3 22670.3 22674.2 22678.8 18255.2 18595.7 18633.9 18644.2 18654.7 3834.6 3987.3 4000.3 4025.8 4040.6 152350.0 162354.0 164560.0 165221.0 165996.0 18815.5 18881.3 19001.3 19065.0 19126.7 34056.5 34721.8 34922.7 35012.8 35081.6 9379.5 9690.5 9693.3 10016.3 10054.2 4575.5 4622.3 4632.4 4634.5 4660.0 5914.6 6007.3 6007.6 6012.0 6141.6 1159.1 1170.2 1194.6 1196.9 1198.6 710.4 722.3 741.9 747.9 749.0 12100.6 12486.1 12704.4 13289.7 13421.9 689.5 703.4 714.9 716.4 718.4 5948.5 6000.6 6064.7 6078.4 6106.2 162669.0 163866.0 164155.0 164922.0 167633.0 117819.0 135000.3 135100.3 140232.0 149573.0 121673.0 121844.0 122046.0 124334.8 125599.4 13229.7 13591.2 13653.7 13677.2 13853.2 56849.7 57795.7 58095.0 58810.4 59200.7 74670.3 75285.6 76066.6 76302.6 78236.6 18427.7 18458.2 18714.0 18869.6 18902.1 21226.7 21554.0 21703.1 21877.2 22069.3 19465.3 19771.7 19984.2 19991.7 20125.1 19502.9 19506.2 19512.5 19914.0 20151.5 17850.5 17975.2 18264.1 18341.5 18368.7 14259.6 14672.9 14681.1 14892.7 14908.5 13961.7 14029.0 14144.9 14180.9 14209.7 18:39:49 INFO - PID 15373 | -------- Summary: end -------- 18:39:49 INFO - PID 15373 | 18:39:50 INFO - TEST-INFO | 15373: exit 0 18:39:50 INFO - TEST-OK | dromaeo_css | took 1107913ms 18:39:50 INFO - TEST-START | kraken 18:39:50 INFO - Initialising browser for kraken test... 18:39:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37354/getInfo.html -profile /tmp/tmpSKU7Wj/profile 18:39:50 INFO - TEST-INFO | started process 15725 (/builds/slave/test/build/application/firefox/firefox http://localhost:37354/getInfo.html) 18:39:55 INFO - TEST-INFO | 15725: exit 0 18:39:56 INFO - Browser initialized. 18:39:56 INFO - Running cycle 1/1 for kraken test... 18:39:56 INFO - Using env: {'DISPLAY': ':0', 18:39:56 INFO - 'HOME': '/home/cltbld', 18:39:56 INFO - 'JSGC_DISABLE_POISONING': '1', 18:39:56 INFO - 'LANG': 'en_US.UTF-8', 18:39:56 INFO - 'LANGUAGE': 'en_US:en', 18:39:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:39:56 INFO - 'LOGNAME': 'cltbld', 18:39:56 INFO - 'MAIL': '/var/mail/cltbld', 18:39:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:39:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:39:56 INFO - 'MOZ_CRASHREPORTER': '1', 18:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:39:56 INFO - 'MOZ_NO_REMOTE': '1', 18:39:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:56 INFO - 'NO_EM_RESTART': '1', 18:39:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:56 INFO - 'PWD': '/builds/slave/test', 18:39:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:39:56 INFO - 'RUST_BACKTRACE': 'full', 18:39:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:39:56 INFO - 'SHELL': '/bin/bash', 18:39:56 INFO - 'SHLVL': '1', 18:39:56 INFO - 'STYLO_FORCE_DISABLED': '1', 18:39:56 INFO - 'TERM': 'linux', 18:39:56 INFO - 'TMOUT': '86400', 18:39:56 INFO - 'USER': 'cltbld', 18:39:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864', 18:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:56 INFO - '_': '/tools/buildbot/bin/python'} 18:39:56 INFO - TEST-INFO | started process 15965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKU7Wj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:56 INFO - PID 15965 | 18:39:56 INFO - PID 15965 | (/builds/slave/test/build/application/firefox/firefox:16015): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:39:56 INFO - PID 15965 | 18:40:07 INFO - PID 15965 | RSS: Main: 144744448 18:40:07 INFO - PID 15965 | 18:40:09 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37354/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:10 INFO - PID 15965 | RSS: Main: 150003712 18:40:10 INFO - PID 15965 | 18:40:13 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37354/tests/kraken/driver.html?testName=audio-dft) 18:40:13 INFO - PID 15965 | RSS: Main: 150630400 18:40:13 INFO - PID 15965 | 18:40:16 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37354/tests/kraken/driver.html?testName=audio-fft) 18:40:17 INFO - PID 15965 | RSS: Main: 147120128 18:40:17 INFO - PID 15965 | 18:40:19 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37354/tests/kraken/driver.html?testName=audio-oscillator) 18:40:19 INFO - PID 15965 | RSS: Main: 148258816 18:40:19 INFO - PID 15965 | 18:40:21 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:22 INFO - PID 15965 | RSS: Main: 148459520 18:40:22 INFO - PID 15965 | 18:40:25 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37354/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:26 INFO - PID 15965 | RSS: Main: 148307968 18:40:26 INFO - PID 15965 | 18:40:29 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37354/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:30 INFO - PID 15965 | RSS: Main: 149569536 18:40:30 INFO - PID 15965 | 18:40:33 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37354/tests/kraken/driver.html?testName=json-parse-financial) 18:40:33 INFO - PID 15965 | RSS: Main: 151207936 18:40:33 INFO - PID 15965 | 18:40:35 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:35 INFO - PID 15965 | RSS: Main: 151212032 18:40:35 INFO - PID 15965 | 18:40:37 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:38 INFO - PID 15965 | RSS: Main: 151265280 18:40:38 INFO - PID 15965 | 18:40:40 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:40 INFO - PID 15965 | RSS: Main: 148553728 18:40:40 INFO - PID 15965 | 18:40:43 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:43 INFO - PID 15965 | RSS: Main: 147800064 18:40:43 INFO - PID 15965 | 18:40:46 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:40:47 INFO - PID 15965 | RSS: Main: 148328448 18:40:47 INFO - PID 15965 | 18:40:48 INFO - PID 15965 | Cycle 1(1): loaded http://localhost:37354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37354/tests/kraken/driver.html?testName=ai-astar) 18:40:49 INFO - PID 15965 | RSS: Main: 149991424 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | __start_tp_report 18:40:49 INFO - PID 15965 | _x_x_mozilla_page_load 18:40:49 INFO - PID 15965 | _x_x_mozilla_page_load_details 18:40:49 INFO - PID 15965 | |i|pagename|runs| 18:40:49 INFO - PID 15965 | |0;ai-astar;107;105;104;104;104;106;106;106;105;105 18:40:49 INFO - PID 15965 | |1;audio-beat-detection;113;111;111;112;111;116;112;110;112;114 18:40:49 INFO - PID 15965 | |2;audio-dft;163;164;161;164;163;163;163;163;165;164 18:40:49 INFO - PID 15965 | |3;audio-fft;72;73;73;73;75;92;74;73;73;74 18:40:49 INFO - PID 15965 | |4;audio-oscillator;79;77;77;77;77;77;77;77;77;77 18:40:49 INFO - PID 15965 | |5;imaging-gaussian-blur;113;113;113;114;113;114;114;113;115;113 18:40:49 INFO - PID 15965 | |6;imaging-darkroom;151;149;149;150;150;153;149;150;149;151 18:40:49 INFO - PID 15965 | |7;imaging-desaturate;95;95;94;96;96;94;94;94;94;93 18:40:49 INFO - PID 15965 | |8;json-parse-financial;43;45;44;43;43;43;44;43;45;44 18:40:49 INFO - PID 15965 | |9;json-stringify-tinderbox;38;39;39;39;39;39;39;39;39;39 18:40:49 INFO - PID 15965 | |10;stanford-crypto-aes;70;69;74;69;71;70;74;69;70;80 18:40:49 INFO - PID 15965 | |11;stanford-crypto-ccm;107;106;110;103;111;108;110;108;101;111 18:40:49 INFO - PID 15965 | |12;stanford-crypto-pbkdf2;150;152;146;152;147;147;155;149;149;158 18:40:49 INFO - PID 15965 | |13;stanford-crypto-sha256-iterative;62;57;60;59;59;59;63;59;60;61 18:40:49 INFO - PID 15965 | __end_tp_report 18:40:49 INFO - PID 15965 | __start_cc_report 18:40:49 INFO - PID 15965 | _x_x_mozilla_cycle_collect,711 18:40:49 INFO - PID 15965 | __end_cc_report 18:40:49 INFO - PID 15965 | __startTimestamp1506562849014__endTimestamp 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | ------- Summary: start ------- 18:40:49 INFO - PID 15965 | Number of tests: 14 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#0] ai-astar Cycles:10 Average:105.20 Median:105.50 stddev:1.03 (1.0%) stddev-sans-first:0.87 18:40:49 INFO - PID 15965 | Values: 107.0 105.0 104.0 104.0 104.0 106.0 106.0 106.0 105.0 105.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#1] audio-beat-detection Cycles:10 Average:112.20 Median:112.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 18:40:49 INFO - PID 15965 | Values: 113.0 111.0 111.0 112.0 111.0 116.0 112.0 110.0 112.0 114.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.06 (0.6%) stddev-sans-first:1.12 18:40:49 INFO - PID 15965 | Values: 163.0 164.0 161.0 164.0 163.0 163.0 163.0 163.0 165.0 164.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#3] audio-fft Cycles:10 Average:75.20 Median:73.50 stddev:5.96 (8.1%) stddev-sans-first:6.21 18:40:49 INFO - PID 15965 | Values: 72.0 73.0 73.0 73.0 75.0 92.0 74.0 73.0 73.0 74.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.00 stddev:0.63 (0.8%) stddev-sans-first:0.00 18:40:49 INFO - PID 15965 | Values: 79.0 77.0 77.0 77.0 77.0 77.0 77.0 77.0 77.0 77.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 18:40:49 INFO - PID 15965 | Values: 113.0 113.0 113.0 114.0 113.0 114.0 114.0 113.0 115.0 113.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 18:40:49 INFO - PID 15965 | Values: 151.0 149.0 149.0 150.0 150.0 153.0 149.0 150.0 149.0 151.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 18:40:49 INFO - PID 15965 | Values: 95.0 95.0 94.0 96.0 96.0 94.0 94.0 94.0 94.0 93.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:44.00 stddev:0.82 (1.9%) stddev-sans-first:0.83 18:40:49 INFO - PID 15965 | Values: 43.0 45.0 44.0 43.0 43.0 43.0 44.0 43.0 45.0 44.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:0.32 (0.8%) stddev-sans-first:0.00 18:40:49 INFO - PID 15965 | Values: 38.0 39.0 39.0 39.0 39.0 39.0 39.0 39.0 39.0 39.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#10] stanford-crypto-aes Cycles:10 Average:71.60 Median:70.50 stddev:3.50 (5.0%) stddev-sans-first:3.67 18:40:49 INFO - PID 15965 | Values: 70.0 69.0 74.0 69.0 71.0 70.0 74.0 69.0 70.0 80.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#11] stanford-crypto-ccm Cycles:10 Average:107.50 Median:109.00 stddev:3.37 (3.1%) stddev-sans-first:3.57 18:40:49 INFO - PID 15965 | Values: 107.0 106.0 110.0 103.0 111.0 108.0 110.0 108.0 101.0 111.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:151.00 stddev:3.81 (2.5%) stddev-sans-first:4.03 18:40:49 INFO - PID 15965 | Values: 150.0 152.0 146.0 152.0 147.0 147.0 155.0 149.0 149.0 158.0 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:1.73 (2.9%) stddev-sans-first:1.66 18:40:49 INFO - PID 15965 | Values: 62.0 57.0 60.0 59.0 59.0 59.0 63.0 59.0 60.0 61.0 18:40:49 INFO - PID 15965 | -------- Summary: end -------- 18:40:49 INFO - PID 15965 | 18:40:49 INFO - PID 15965 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:40:49 INFO - TEST-INFO | 15965: exit 0 18:40:49 INFO - TEST-OK | kraken | took 59195ms 18:40:49 INFO - SUITE-END | took 1167s 18:40:49 INFO - Completed test suite (00:19:27) 18:40:49 INFO - javascript benchmark 18:40:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9202.883608674185, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3799.924001519969, 3818.7517811342277, 3823.827927743251, 3850.8459661613538, 3855.0169706724782, 6102.145699602059, 6115.908261376083, 6180.536459765519, 6206.534509911758, 6234.968825155874, 6218.129461875341, 6250.9062364064575, 6258.62448253104, 6261.906071408933, 6299.023651334051, 5619.662820230778, 5682.204491371212, 5714.771409143629, 5729.0, 5742.339630942453, 5675.631083979549, 5680.943190568103, 5742.454466825666, 5768.077107662775, 5778.0466223073145, 5502.8349149525575, 5610.663360198401, 5618.550515958714, 5650.886982260352, 5695.886082278331, 5619.915701264485, 5651.547876169897, 5667.886642267173, 5687.061634830248, 5707.828765137011, 5551.944480555224, 5567.276254086943, 5607.887842243133, 5678.971605141989, 5695.088785794253, 6233.563650544464, 6234.0960560718895, 6250.093736408241, 6259.968700156515, 6298.527610429191, 6736.8989465158065, 6762.425193858528, 6824.078749368821, 6839.521233513656, 6840.281770414084, 6702.597844129319, 6750.088738020353, 6795.38841504262, 6810.0, 6879.105716256855, 6248.4688801451475, 6258.624482531062, 6264.843378915518, 6303.842403939892, 6392.137061496638, 6922.965385173143, 6991.720331186797, 6999.860002800017, 7000.054992576039, 7004.0, 6559.639219842859, 6675.432588229958, 6693.732250710014, 6732.023856540774, 6772.5936443813525, 6783.18601767791, 6830.795076147723, 6863.245043045261, 6864.0, 6901.930980690229, 6725.428338591275, 6758.695858686371, 6791.456683465311, 6819.965900170468, 6820.624865632339, 6718.0, 6744.359285867835, 6753.189617245962, 6753.257141714505, 6854.383105520527, 4933.531314525115, 4978.178600530872, 4983.103041452573, 5017.222330538772, 5054.16606259963, 4491.595756381941, 4547.47704014036, 4556.726596404226, 4568.543145685471, 4610.469795973506, 6222.968885155636, 6242.563020588606, 6290.937090629127, 6295.905561416583, 6315.210598675166, 6649.73401063952, 6709.060731497594, 6756.763513277012, 6760.222574403908, 6770.93229067703, 6122.234720659918, 6186.4741496972365, 6253.593516421418, 6284.4344009039405, 6301.40136687014, 5412.972935135299, 5488.423715509894, 5498.230247765316, 5502.284702988586, 5504.834854954358, 6871.484638652121, 6911.827204319932, 6954.0, 6978.092847929838, 7016.5790052597, 6672.899906501503, 6686.0, 6717.0, 6717.2946840581035, 6735.6968936397, 6928.341807528277, 7004.089468369283, 7038.542494737826, 7071.328223818729, 7096.574205547684, 6708.966455167693, 6755.121834161528, 6792.150981127359, 6817.522773406013, 6826.453883689193, 6689.966550167218, 6741.325867413219, 6749.696263668048, 6845.418139458003, 6849.1780986281965, 6507.902381464187, 6521.510886683613, 6574.0, 6581.0, 6581.0, 6253.468455181179, 6547.803565893031, 6553.934460655332, 6565.113709649137, 6569.4744420445295, 6391.360863913572, 6416.711247993758, 6449.322821103717, 6506.381893720279, 6546.116274302908, 6493.837654058686, 6547.70535325921, 6568.080468734285, 6658.966705166443, 6661.267260601427, 6387.936120638734, 6450.54846160783, 6463.450606698483, 6466.256380516113, 6472.773452929125], "value": 6188.589845784299, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.8950170730368, 913.0641092879802, 924.6624981881614, 957.1433566957573, 962.8700125483058, 44074.77962610187, 44550.55449445505, 44707.77646111769, 44779.10441791162, 44843.32735008969, 41949.0, 42208.78895605525, 42285.36571951416, 42343.78828105855, 42387.364189537104, 7401.962990185041, 7511.849763004737, 7523.4357423193205, 7558.35753960914, 7585.013948186755, 7456.328930396263, 7506.399488040944, 7561.979132817082, 7566.129895062056, 7573.810654733648, 7540.2082781308, 8311.418200725951, 8486.702965396213, 8517.23344898959, 8548.230659240668, 8422.663093476254, 8494.447860889084, 8497.107803680587, 8497.320214382866, 8497.915020849805, 8156.2659360657235, 8333.250007499293, 8431.241188293021, 8442.915570844274, 8444.493330400195, 41009.179816403805, 41229.1754164918, 41240.793796030826, 41294.38058429126, 41337.79331103355, 3656.2504686539196, 3667.94498082529, 3691.2986532559, 3692.9659695285363, 3695.0392897846486, 33745.325093497995, 33977.15057123567, 34018.6598134018, 34034.149146271295, 34038.14904627379, 5449.1826226066405, 5461.5357694596005, 5505.201745746845, 5553.305836770403, 5555.861103472405, 221539.0, 222423.0, 222921.0, 223645.99999999837, 223713.0, 53897.1915421269, 53937.0, 54013.0, 54050.45949540533, 54130.45869541254, 55528.44471555314, 55857.720711396185, 55914.72042639761, 56065.43934560602, 56099.71950140223, 17129.14354282281, 17402.65194696099, 17406.129693515275, 17437.47687569375, 17536.035518046374, 14330.140191588538, 14396.784048239284, 14425.350859211361, 14441.422343106158, 14446.855531444551, 14613.78079328811, 14746.18895960711, 14802.333894974752, 14828.481003165054, 15019.173945432887, 5749.660364964567, 5773.740181691834, 5821.825345239649, 5933.970330148321, 5986.760529578855, 1086.2396322574073, 1097.9121670266359, 1097.983530247047, 1099.0712847643729, 1117.6591139702468, 25637.3590660235, 26011.0, 26112.216633501026, 26189.476210475685, 26305.868470657526, 1193.5524178433088, 1205.9809461005436, 1206.5354838387284, 1230.926144431319, 1238.6717519857245, 13506.729865402636, 13546.119502232323, 13624.250666213255, 13721.108127971649, 13984.0, 294137.0, 295594.0, 296054.0, 296809.0, 297061.0, 53855.73072134614, 64114.0, 65282.347176527626, 65520.34479655143, 65614.0, 1533.0418488444723, 1540.2991638804317, 1547.7678348247853, 1554.1063888264518, 1572.5989872582418, 30407.0, 30897.227569310948, 31095.222619434695, 31149.221269468446, 31233.219169520944, 42514.78742606267, 42749.572504275806, 42828.57171428246, 42908.57091429046, 42910.141797164506, 241895.0, 242584.0, 242694.0, 242831.0, 243504.0, 34793.304133917685, 35638.8218058908, 35854.82072589621, 35863.0, 36071.0, 46552.301715474976, 46847.53152468432, 47338.05323893572, 47588.0, 47617.0, 34177.31645367129, 34544.0, 34806.30387392289, 34990.0, 35281.47077793886, 34421.483677744356, 34823.30353392867, 34872.30255394827, 34905.0, 35458.468122978695, 40539.594604053585, 41371.379429307985, 41416.0, 41819.0, 41848.58151418569, 33385.0, 33884.830575846965, 34113.65886341204, 34143.82928085443, 34605.30789384249, 25005.74994250034, 25193.748062519142, 25300.873495632404, 25688.0, 25938.610920835825], "value": 18829.48108886677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.0361959107861, 636.0855084811401, 639.6205047947235, 644.0418774261851, 649.8797722421356, 23155.884220578893, 23608.173713920016, 24125.15561955332, 24194.75805241947, 24926.626100608504, 27360.315992100208, 27640.308992275204, 27662.170134895987, 27696.584551231746, 27699.723002769966, 6594.0, 6658.234303055138, 6812.4550035997245, 6818.9659051704675, 6829.078074459959, 6831.180258369002, 6858.588484690935, 6865.862682746342, 6881.552699074544, 6887.7244910203535, 6794.898076528856, 6827.249002609709, 6839.1451068616425, 6840.28177041411, 6850.109485766843, 6840.692168852389, 6843.931560684404, 6846.383825455733, 6846.554973926679, 6854.177498700163, 6400.0, 6400.135981642466, 6414.4227019568, 6415.0, 6415.679216039226, 29460.705392946224, 31678.208044799063, 31873.681263187536, 31904.840475797704, 31968.520472192937, 2225.554889022202, 2235.508188198594, 2235.5417139486367, 2238.2278114050628, 2241.2267767620147, 20473.692894606593, 20555.48611284715, 20924.581508369898, 21321.893390533103, 21345.786542134534, 2602.414456747236, 2621.3839747659285, 2638.511875303075, 2645.9867700661375, 2656.8273062251087, 135051.0, 141020.29489852587, 141535.0, 154472.0, 160709.16099614516, 16294.918525407535, 16697.580705639914, 16850.241739121768, 17073.829261707473, 17141.914290428467, 27395.178144655692, 27490.17529474119, 27581.724182758317, 27610.723892761216, 27641.447171056465, 10822.350658960488, 10874.184436167161, 11143.944280278709, 11181.540061186526, 11188.720281992852, 10092.596296148218, 10138.746531336776, 10187.694369168938, 10207.591696332212, 10276.126529244948, 9874.753131171778, 9875.209983201326, 9981.101700846959, 10047.547860346156, 10348.275620706478, 2889.812162209492, 2899.7390234878962, 2959.837208953485, 2974.732274095342, 3031.6968303169506, 1032.4218437674926, 1036.3522798251092, 1041.2763129624839, 1044.216837371971, 1045.3466583385384, 21318.360449186548, 21497.247596334368, 21687.67468487974, 21698.34904952854, 21736.782632173792, 1090.2150451674781, 1104.5140138339104, 1105.5798796457295, 1110.9611163609236, 1121.8261169518737, 11718.179727419169, 11759.235649682743, 11781.882181178249, 11958.043356531456, 12021.398930053463, 587905.0, 592246.038769812, 596616.0, 600974.0, 606014.0, 133187.33406332906, 133644.0, 134309.32845335905, 134456.0, 134726.32636836948, 1067.9679609611724, 1245.800671892511, 1269.0, 1286.0290480687208, 1294.0294778915813, 21545.89227053855, 22237.77762222357, 22465.43836404103, 22563.77436225617, 22948.082076716746, 61743.6912815433, 62334.37665623286, 63329.68335158479, 63838.68080659567, 64932.67533662301, 82175.17824821915, 82641.17358826335, 82896.58551707203, 83148.0, 83508.0, 21283.36149915505, 21854.235101771363, 21969.0, 22014.779852201274, 22018.779812202312, 23724.0, 24454.87772561126, 24511.877440612683, 24600.261992140266, 24609.753902460747, 19832.0, 20167.69748453745, 20188.495287617927, 20405.59188816245, 20421.285255016002, 17920.551986200448, 18152.0, 18403.63192736111, 18546.350877719215, 18719.90640046791, 19813.0, 20448.79551204469, 20451.181952721723, 20545.89727051415, 20646.17415303371, 21247.78752212458, 21349.89325053365, 21358.145674172858, 21459.785402146405, 21514.247001354877, 19612.803871961667, 19783.208671652974, 19841.30555430553, 19859.404217873485, 19882.90058549698], "value": 13313.508862190858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.1647011792923, 1438.5180964376934, 1447.8334991475976, 1453.215263757571, 1457.1839769728952, 17260.91369543152, 17948.55128621785, 17970.281188752433, 17973.101344932766, 18024.188911498964, 17608.383706570272, 17773.022483763387, 17803.73294400585, 17818.64362712745, 17831.0, 2743.5198840202984, 2873.1524200360946, 2881.2076678913363, 2893.4213157368504, 2895.55118956561, 2567.9101231456902, 2697.9190624281305, 2701.8784154712985, 2702.216357256393, 2704.283364908301, 2724.577690457982, 2915.7375836174847, 2923.342247994195, 2928.2386579489275, 2928.3704003639214, 2568.268043607572, 2592.857392843393, 2615.777658898996, 2616.5551856184493, 2620.4104076582807, 2634.2229042432527, 2655.8804853781626, 2669.439417722261, 2685.207863680219, 2691.932701682454, 15779.763303550455, 16049.91975040129, 16090.839091609168, 16109.516714498584, 16114.11372374519, 8646.394752367336, 8930.86603700945, 8933.6873209438, 8939.240164586017, 8947.239484643747, 5594.1888426177975, 5682.40334764852, 5715.885682286373, 5832.300123985149, 5899.233099697055, 2109.7671844736815, 2132.4349047502424, 2139.1229595865775, 2165.350394881545, 2172.3700126963163, 32754.181145471317, 32868.0, 33122.6687733122, 33616.49575256373, 33682.99999999975, 7279.854402911912, 7389.150247721581, 7440.3675687567165, 7468.141163766237, 7513.849723005509, 20838.479038023866, 20860.791392085885, 20880.79119208819, 20883.37349879506, 20898.686519702216, 8538.146185381413, 8558.186972237627, 8633.827323453495, 8651.6971905983, 8666.176713212235, 7860.371170306362, 7879.724209652749, 7985.560794156378, 7999.240072193249, 8062.0, 5510.972445137829, 5671.319441667027, 5672.517835983905, 5723.998300297431, 5726.856828579319, 1693.6443346897042, 1736.1319340329835, 1747.2923465996291, 1766.646670665872, 1771.7076682347526, 979.8383266761048, 985.5072463768116, 999.0658734083655, 1014.1227837920146, 1018.256672628985, 8642.898446690959, 8652.394332396672, 8802.987656419466, 8842.91157088421, 8992.46045237288, 718.9784306470814, 743.108270075911, 751.2374939436368, 759.787259567322, 762.954222746637, 5416.268803711528, 5454.7272636368025, 6118.20463339763, 6173.783917562953, 6347.52393570484, 25102.372440688763, 25926.481470370487, 26168.214953551425, 26513.204603861916, 26850.865745671148, 25363.98544058217, 25684.614730779052, 26185.34536636561, 26386.94452221928, 26425.86787066091, 10775.676729698122, 11123.55505779776, 12562.309073001255, 13090.738185236241, 13315.800262996063, 9685.273604479551, 9712.465814380277, 9789.118979291898, 9899.257555683209, 9991.450470223917, 20637.0, 20847.791522084586, 21258.36224913255, 21683.891580542626, 22056.228032018804, 22375.664365034212, 22407.77592224122, 22482.0, 22567.32298031062, 22761.658575121055, 11960.820587691365, 12115.454804533641, 12188.939055304667, 12209.69475763113, 12233.632991010283, 15486.612834678772, 15498.690026199638, 15567.532974010797, 15594.610134746723, 15629.531114066596, 11808.291502509877, 12536.247825130522, 12547.560835370718, 12575.748485030432, 12588.622341329774, 11645.184837061324, 12073.57742479009, 12305.630831075083, 12623.621291361274, 12686.555970540987, 10703.19726020536, 10962.561497540328, 10975.725606859893, 10981.835272471078, 10984.286021408583, 8644.697435589724, 8673.349498787742, 8746.65013399457, 8816.735497935073, 8839.16027977341, 8292.502449853027, 8306.210909963544, 8317.95841020791, 8335.291500222307, 8361.414700971118], "value": 7340.830212558377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4423160492101, 550.1500182218477, 550.2379204801349, 560.1653536231016, 581.2792137749192, 6225.937740622592, 6270.028145637428, 6297.275813281468, 6299.527535434843, 6381.712822922968, 6243.71903264353, 6286.748530058792, 6287.1198032275515, 6350.777722779703, 6365.904511432333, 4951.727654978975, 5134.409542902558, 5201.401838788531, 5208.973955130219, 5216.530512253897, 5006.0, 5010.974945125269, 5016.423111342206, 5049.899002019957, 5050.131451363, 4960.131976904046, 4962.702237865721, 4988.575971042465, 5026.29631851541, 5041.395032596093, 4987.925181122286, 5003.199488081926, 5003.399592048941, 5016.122178618727, 5053.722045287508, 4559.6124329431705, 4578.2903649934315, 4588.977055114737, 4603.217453032959, 4609.516000819933, 6250.718717657716, 6270.874582508324, 6301.6534090625, 6315.621062736251, 6354.459870910978, 5803.446483547225, 5819.330776960662, 5827.912581311241, 5871.9412805871825, 5957.404259574051, 6629.839778038824, 6656.3691895485435, 6697.6986035628515, 6700.363465470772, 6748.527603067787, 5110.437851836295, 5141.203113517411, 5147.6654017488745, 5151.7681704323395, 5193.662411943249, 6996.772872143796, 7028.753993610199, 7061.258567850353, 7117.964410177968, 7118.572885626827, 5200.76596553156, 5269.762860671279, 5292.5501332387175, 5295.947040529622, 5333.786648534093, 5407.107827208467, 5409.783608655688, 5419.214213938957, 5423.728813559306, 5428.2671839301975, 5829.446202610745, 5877.589378549203, 5909.527237820964, 5914.64512129265, 5925.822225333247, 6305.801897639434, 6540.967295163494, 6595.901061484082, 6622.602643841385, 6775.322467753185, 1833.2208811255164, 1842.6222624362242, 1856.3595559531939, 1862.981370186308, 1865.6753704869423, 1249.4689756853484, 1304.2630913534013, 1315.960521184366, 1337.0106121470042, 1338.1569611144917, 6172.753089876354, 6200.534959878028, 6212.161358216673, 6255.186825712719, 6269.8746025079245, 6714.395704386531, 6809.421199198025, 6823.112995310578, 6840.31596840312, 6887.724491020404, 6241.7191226394925, 6268.1851359323, 6302.684865756693, 6360.395762402564, 6378.489720822323, 3554.7689400188906, 3606.891793246207, 3607.7294202934886, 3611.566612006576, 3654.780713157219, 7052.858942821114, 7088.858222835514, 7100.183478899992, 7103.644817759091, 7161.5676864627285, 7021.964890175618, 7050.259722729143, 7078.858422831618, 7100.9289907100265, 7105.147382314155, 7018.719251229996, 7067.222605513492, 7089.539179953286, 7147.499675022803, 7207.45944054198, 6798.354156355138, 6871.415929646036, 6896.862062758817, 6920.342567456084, 6958.582485050913, 6296.338884417253, 6715.932840671726, 6740.561863478858, 6777.864442711217, 6797.422219111233, 6767.492438067263, 6834.557537600599, 6888.965555172192, 6891.896621550581, 6995.230524642387, 5114.181730923035, 5219.869503262449, 5250.527452529291, 5253.317068781034, 5274.525292723673, 6508.511861610304, 6517.348265173445, 6634.042957327696, 6885.758998435031, 6974.860502790018, 6480.116348224995, 6556.868862622816, 6586.8353291168105, 6619.966900165661, 6627.502937279627, 6585.473162147113, 6589.571677840925, 6602.966985165043, 6602.966985165235, 6674.265830758515, 6416.743330266737, 6554.377334153248, 6560.212774467094, 6564.868702626016, 6627.403533681992, 6629.834254143685, 6637.8383782836845, 6687.0, 6745.628990405378, 6776.28848970851, 6432.453241474527, 6438.935610643834, 6467.15926929515, 6471.320511346429, 6530.281669016499], "value": 5231.925862040119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.2049089010676, 959.8080383923215, 988.5551501824176, 992.5483904823307, 999.8600195972565, 19677.0, 20239.898800506013, 20248.59502809943, 20310.289139880108, 20320.796792032095, 19067.332643357484, 19544.51138721529, 19580.902095489502, 19732.40802775919, 19806.0, 1022.9488525573729, 1035.9847349597399, 1040.032769524342, 1040.9427481488515, 1041.8801837788637, 1010.9696709098702, 1043.9530221140028, 1052.7420781908404, 1055.408970976252, 1056.023178559833, 1130.2314426190187, 1130.8416821644976, 1132.1169487799489, 1132.224426268009, 1136.551062330379, 1119.641714651312, 1123.084685980923, 1126.8084425647578, 1129.305477131558, 1133.529585222136, 823.7611092783086, 829.5810615639124, 833.1668331668332, 834.5952213176605, 838.5429940682343, 18119.818801811944, 20010.0, 20032.29886953964, 20274.89862550678, 20279.0, 22284.220052298253, 22562.307826913046, 22670.319890403316, 22674.206402775824, 22678.77321226783, 18255.178516966636, 18595.721064183912, 18633.906830465898, 18644.161012754324, 18654.720179197324, 3834.5973672764517, 3987.2623564640344, 4000.3399439092514, 4025.838966441339, 4040.6363427291685, 152350.0, 162353.9999999988, 164560.0, 165221.0, 165996.0, 18815.529611759543, 18881.339153129575, 19001.334953276844, 19065.04674766256, 19126.71309930352, 34056.48915266273, 34721.826390867885, 34922.650773492445, 35012.82493587516, 35081.64918350784, 9379.48412837287, 9690.51547422626, 9693.273004524688, 10016.29885907994, 10054.245931555162, 4575.450945886515, 4622.260438329851, 4632.374629424984, 4634.46703629087, 4659.976700116477, 5914.615549989237, 6007.30915944672, 6007.639541627516, 6011.977963746086, 6141.6007959482495, 1159.084323384517, 1170.2042611024585, 1194.6296648039136, 1196.874328195527, 1198.5924785572772, 710.4210068793916, 722.2705067881373, 741.8738814401564, 747.872861613527, 749.0300061420473, 12100.636980890587, 12486.063545233963, 12704.36478176106, 13289.667758305926, 13421.932890335485, 689.5449003657562, 703.3529153179087, 714.8927660850914, 716.3660160757663, 718.4432065149551, 5948.524118070544, 6000.579959402888, 6064.696765161812, 6078.361772013964, 6106.236720409949, 162669.0, 163866.0, 164155.0, 164922.0, 167633.0, 117819.0, 135000.3249983744, 135100.32449837687, 140232.0, 149573.0, 121673.0, 121844.0, 122046.0, 124334.75665243412, 125599.3720031394, 13229.669258268621, 13591.184528928296, 13653.658658533219, 13677.179369237878, 13853.168809871037, 56849.715751420976, 57795.71102144462, 58095.0, 58810.41189588221, 59200.703996479744, 74670.2532974685, 75285.62357188179, 76066.61966690132, 76302.61848690722, 78236.60881695554, 18427.723584146515, 18458.169382377557, 18714.0, 18869.622607548048, 18902.054897254806, 21226.681599776326, 21554.0, 21703.131874724833, 21877.234296799536, 22069.33791986243, 19465.318713844947, 19771.703424448933, 19984.20063197456, 19991.700124498435, 20125.094370753643, 19502.90248548748, 19506.219751209792, 19512.512187195432, 19914.0, 20151.496212594804, 17850.464486065437, 17975.191116399532, 18264.08679566043, 18341.541461463035, 18368.724469132707, 14259.572212833631, 14672.853271467575, 14681.119132852064, 14892.702145957237, 14908.478203262834, 13961.720765584834, 14029.01796874209, 14144.858551414354, 14180.858191418367, 14209.715805684034], "value": 10194.988833183195, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1363.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 104.0, 104.0, 104.0, 106.0, 106.0, 106.0, 105.0, 105.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 112.0, 111.0, 116.0, 112.0, 110.0, 112.0, 114.0], "value": 112.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 164.0, 163.0, 163.0, 163.0, 163.0, 165.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 75.0, 92.0, 74.0, 73.0, 73.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 150.0, 150.0, 153.0, 149.0, 150.0, 149.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 96.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 44.0, 43.0, 43.0, 43.0, 44.0, 43.0, 45.0, 44.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 74.0, 69.0, 71.0, 70.0, 74.0, 69.0, 70.0, 80.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 110.0, 103.0, 111.0, 108.0, 110.0, 108.0, 101.0, 111.0], "value": 107.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 146.0, 152.0, 147.0, 147.0, 155.0, 149.0, 149.0, 158.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 57.0, 60.0, 59.0, 59.0, 59.0, 63.0, 59.0, 60.0, 61.0], "value": 59.9, "unit": "score"}]}]} 18:40:49 INFO - Return code: 0 18:40:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:40:49 INFO - # TBPL SUCCESS # 18:40:49 INFO - Running post-action listener: _package_coverage_data 18:40:49 INFO - Running post-action listener: _resource_record_post_action 18:40:49 INFO - [mozharness: 2017-09-28 01:40:49.796091Z] Finished run-tests step (success) 18:40:49 INFO - Running post-run listener: _resource_record_post_run 18:40:49 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318435328; Read time: 16; Write time: 219736 18:40:49 INFO - TinderboxPrint: CPU usage
13.1% 18:40:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:40:49 INFO - TinderboxPrint: I/O write bytes / time
318,435,328 / 219,736 18:40:49 INFO - TinderboxPrint: CPU idle
8,211.6 (86.9%) 18:40:49 INFO - TinderboxPrint: CPU user
1,187.1 (12.6%) 18:40:49 INFO - TinderboxPrint: Swap in / out
0 / 0 18:40:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13279232; Read time: 0; Write time: 2592 18:40:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:40:49 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304521216; Read time: 16; Write time: 217136 18:40:50 INFO - Running post-run listener: _upload_blobber_files 18:40:50 INFO - Blob upload gear active. 18:40:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:40:50 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 18:40:50 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'] 18:40:50 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 18:40:50 INFO - (blobuploader) - INFO - Open directory for files ... 18:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:40:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:51 INFO - (blobuploader) - INFO - Done attempting. 18:40:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:52 INFO - (blobuploader) - INFO - Done attempting. 18:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:53 INFO - (blobuploader) - INFO - Done attempting. 18:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:00 INFO - (blobuploader) - INFO - Done attempting. 18:41:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:41:00 INFO - Return code: 0 18:41:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:41:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:41:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b25d56566ddaab540ff50296da2f6166190764fd6561749b98fee8dd6854123ab425fb8e8e60b73a3e8488f92fcd0b93035de0aca5668fcba67dac5927145d10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c238729a10134094a5567a4da3fea9313dae3ce5f7ae9e7ad13fb8d621526781af9dc48a04fcfffd1cd2ee50bf597a415afdf7909a70d5aa3510baeacfc0ae21", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb58fb8fd06a9cf4dd771ea92a5b5cf99fdd0a496af96302407ca2416861ae3ae4e58bac7cfa43648936417a86f4ff19e48e4236befe5e314c3016267ffd2305", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d23f3889bff0bb47270f79304112b09ae30208c1b8002f911d36b941f81f942e2fb65ac502278a7f427108dba3388550d55901a83d24975328e8435c71e1628"} 18:41:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:41:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:41:00 INFO - Contents: 18:41:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b25d56566ddaab540ff50296da2f6166190764fd6561749b98fee8dd6854123ab425fb8e8e60b73a3e8488f92fcd0b93035de0aca5668fcba67dac5927145d10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c238729a10134094a5567a4da3fea9313dae3ce5f7ae9e7ad13fb8d621526781af9dc48a04fcfffd1cd2ee50bf597a415afdf7909a70d5aa3510baeacfc0ae21", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb58fb8fd06a9cf4dd771ea92a5b5cf99fdd0a496af96302407ca2416861ae3ae4e58bac7cfa43648936417a86f4ff19e48e4236befe5e314c3016267ffd2305", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d23f3889bff0bb47270f79304112b09ae30208c1b8002f911d36b941f81f942e2fb65ac502278a7f427108dba3388550d55901a83d24975328e8435c71e1628"} 18:41:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:41:00 INFO - Copying logs to upload dir... 18:41:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:41:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.928997 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-27 18:41:00.422064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 18:41:00.425973) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864 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/b25d56566ddaab540ff50296da2f6166190764fd6561749b98fee8dd6854123ab425fb8e8e60b73a3e8488f92fcd0b93035de0aca5668fcba67dac5927145d10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c238729a10134094a5567a4da3fea9313dae3ce5f7ae9e7ad13fb8d621526781af9dc48a04fcfffd1cd2ee50bf597a415afdf7909a70d5aa3510baeacfc0ae21", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb58fb8fd06a9cf4dd771ea92a5b5cf99fdd0a496af96302407ca2416861ae3ae4e58bac7cfa43648936417a86f4ff19e48e4236befe5e314c3016267ffd2305", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d23f3889bff0bb47270f79304112b09ae30208c1b8002f911d36b941f81f942e2fb65ac502278a7f427108dba3388550d55901a83d24975328e8435c71e1628"} build_url:https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/Nd2wp_F6SlCE3VuynIQczQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b25d56566ddaab540ff50296da2f6166190764fd6561749b98fee8dd6854123ab425fb8e8e60b73a3e8488f92fcd0b93035de0aca5668fcba67dac5927145d10", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c238729a10134094a5567a4da3fea9313dae3ce5f7ae9e7ad13fb8d621526781af9dc48a04fcfffd1cd2ee50bf597a415afdf7909a70d5aa3510baeacfc0ae21", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb58fb8fd06a9cf4dd771ea92a5b5cf99fdd0a496af96302407ca2416861ae3ae4e58bac7cfa43648936417a86f4ff19e48e4236befe5e314c3016267ffd2305", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d23f3889bff0bb47270f79304112b09ae30208c1b8002f911d36b941f81f942e2fb65ac502278a7f427108dba3388550d55901a83d24975328e8435c71e1628"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 18:41:00.461708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:41:00.462069) ========= 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=a0d2d2de893abaa8702a9954000001a7-1506561621.328420-1835200864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:41:00.541565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 18:41:00.541883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 18:41:00.542201) ========= ========= Total master_lag: 0.22 =========