builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-055 starttime: 1506940225.66 results: success (0) revision: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.657796) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.658160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.658587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.722856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.723121) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 03:30:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.5M=0s 2017-10-02 03:30:25 (34.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178755 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.967436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:25.970758) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.022796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.023095) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 --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 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 --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=bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 03:30:26,094 truncating revision to first 12 chars 2017-10-02 03:30:26,094 Setting DEBUG logging. 2017-10-02 03:30:26,094 attempt 1/10 2017-10-02 03:30:26,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a2877a3738c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 03:30:26,475 unpacking tar archive at: mozilla-central-0a2877a3738c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.741258 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.789868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.790137) ========= script_repo_revision: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.790496) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.790771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 03:30:26.806855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-10-02 03:30:26.807114) ========= /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=bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:27 INFO - MultiFileLogger online at 20171002 03:30:27 in /builds/slave/test 03:30:27 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 03:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:27 INFO - {'append_to_log': False, 03:30:27 INFO - 'base_work_dir': '/builds/slave/test', 03:30:27 INFO - 'blob_upload_branch': 'Firefox', 03:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:27 INFO - 'branch': 'Firefox', 03:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:27 INFO - 'code_coverage': False, 03:30:27 INFO - 'config_files': ('talos/linux_config.py',), 03:30:27 INFO - 'default_actions': ('clobber', 03:30:27 INFO - 'read-buildbot-config', 03:30:27 INFO - 'download-and-extract', 03:30:27 INFO - 'populate-webroot', 03:30:27 INFO - 'create-virtualenv', 03:30:27 INFO - 'install', 03:30:27 INFO - 'setup-mitmproxy', 03:30:27 INFO - 'run-tests'), 03:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:27 INFO - 'disable_ccov_upload': False, 03:30:27 INFO - 'disable_stylo': False, 03:30:27 INFO - 'download_minidump_stackwalk': True, 03:30:27 INFO - 'download_symbols': 'ondemand', 03:30:27 INFO - 'enable_stylo': False, 03:30:27 INFO - 'enable_webrender': False, 03:30:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:27 INFO - 'gecko_profile': False, 03:30:27 INFO - 'gecko_profile_interval': 0, 03:30:27 INFO - 'installer_path': 'installer.exe', 03:30:27 INFO - 'log_level': 'info', 03:30:27 INFO - 'log_name': 'talos', 03:30:27 INFO - 'log_to_console': True, 03:30:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:27 INFO - 'opt_config_files': (), 03:30:27 INFO - 'pip_index': False, 03:30:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:30:27 INFO - 'system_bits': '32', 03:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:27 INFO - 'title': 'talos-linux64-ix-055', 03:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:27 INFO - 'use_talos_json': True, 03:30:27 INFO - 'verify': 'False', 03:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:27 INFO - 'work_dir': 'build'} 03:30:27 INFO - [mozharness: 2017-10-02 10:30:27.102571Z] Running clobber step. 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: clobber 03:30:27 INFO - rmtree: /builds/slave/test/build 03:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:28 INFO - Running post-action listener: _resource_record_post_action 03:30:28 INFO - [mozharness: 2017-10-02 10:30:28.057044Z] Finished clobber step (success) 03:30:28 INFO - [mozharness: 2017-10-02 10:30:28.057142Z] Running read-buildbot-config step. 03:30:28 INFO - Running pre-action listener: _resource_record_pre_action 03:30:28 INFO - Running main action method: read_buildbot_config 03:30:28 INFO - Using buildbot properties: 03:30:28 INFO - { 03:30:28 INFO - "project": "", 03:30:28 INFO - "product": "firefox", 03:30:28 INFO - "who": "archaeopteryx@coole-files.de", 03:30:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:30:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:30:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:30:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:30:28 INFO - "stage_platform": "linux64-pgo", 03:30:28 INFO - "basedir": "/builds/slave/test", 03:30:28 INFO - "buildnumber": 82, 03:30:28 INFO - "platform": "ubuntu64_hw", 03:30:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:30:28 INFO - "slavebuilddir": "test", 03:30:28 INFO - "taskId": "LKdME-SQSFGNVknJpN8LtQ", 03:30:28 INFO - "branch": "mozilla-central", 03:30:28 INFO - "script_repo_revision": "production", 03:30:28 INFO - "revision": "0a2877a3738c35b1cb9c6073d6c5be76f9c07656", 03:30:28 INFO - "slavename": "talos-linux64-ix-055", 03:30:28 INFO - "repo_path": "mozilla-central" 03:30:28 INFO - } 03:30:28 INFO - Finding installer, test and symbols from parent task. 03:30:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LKdME-SQSFGNVknJpN8LtQ'}, attempt #1 03:30:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LKdME-SQSFGNVknJpN8LtQ'}, attempt #1 03:30:28 INFO - Task dependencies: feUfNV96Qne6kN5PXEa8NA 03:30:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA'}, attempt #1 03:30:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2 03:30:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.test_packages.json 03:30:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.crashreporter-symbols.zip 03:30:29 INFO - Running post-action listener: _resource_record_post_action 03:30:29 INFO - [mozharness: 2017-10-02 10:30:29.388601Z] Finished read-buildbot-config step (success) 03:30:29 INFO - [mozharness: 2017-10-02 10:30:29.388821Z] Running download-and-extract step. 03:30:29 INFO - Running pre-action listener: _resource_record_pre_action 03:30:29 INFO - Running main action method: download_and_extract 03:30:29 INFO - mkdir: /builds/slave/test/build/tests 03:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:29 INFO - trying https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.test_packages.json 03:30:29 INFO - Downloading https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:30:29 INFO - Downloaded 989 bytes. 03:30:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:30:29 INFO - Using the following test package requirements: 03:30:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:30:29 INFO - u'common': [u'target.common.tests.zip'], 03:30:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:30:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:30:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:30:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:30:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:30:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:30:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:30:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:30:29 INFO - u'target.web-platform.tests.tar.gz'], 03:30:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:30:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:30:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.common.tests.zip 03:30:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:30:29 INFO - Fetch https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.common.tests.zip into memory 03:30:32 INFO - Content-Length response header: 55912669 03:30:32 INFO - Bytes received: 55912669 03:30:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.talos.tests.zip 03:30:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:30:43 INFO - Fetch https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.talos.tests.zip into memory 03:30:44 INFO - Content-Length response header: 14522385 03:30:44 INFO - Bytes received: 14522385 03:30: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')]} 03:30:44 INFO - trying https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2 03:30:44 INFO - Downloading https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:30:47 INFO - Downloaded 62358409 bytes. 03:30:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2 03:30:47 INFO - mkdir: /builds/slave/test/properties 03:30:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:47 INFO - Contents: 03:30:47 INFO - build_url:https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2 03:30:47 INFO - Running post-action listener: _resource_record_post_action 03:30:47 INFO - Running post-action listener: find_tests_for_verification 03:30:47 INFO - Running post-action listener: set_extra_try_arguments 03:30:47 INFO - [mozharness: 2017-10-02 10:30:47.398111Z] Finished download-and-extract step (success) 03:30:47 INFO - [mozharness: 2017-10-02 10:30:47.398209Z] Running populate-webroot step. 03:30:47 INFO - Running pre-action listener: _resource_record_pre_action 03:30:47 INFO - Running main action method: populate_webroot 03:30:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['tresize', 03:30:47 INFO - 'tcanvasmark']}, 03:30:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['dromaeo_css', 03:30:47 INFO - 'kraken']}, 03:30:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'tests': ['damp', 'tps']}, 03:30:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['damp', 'tps']}, 03:30:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['dromaeo_dom']}, 03:30:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:30:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['basic_compositor_video', 03:30:47 INFO - 'glvideo']}, 03:30:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:30:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['ts_paint_webext', 03:30:47 INFO - 'tp5o_webext']}, 03:30:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:47 INFO - 'ts_paint', 03:30:47 INFO - 'tpaint', 03:30:47 INFO - 'sessionrestore', 03:30:47 INFO - 'sessionrestore_many_windows', 03:30:47 INFO - 'sessionrestore_no_auto_restore', 03:30:47 INFO - 'tabpaint', 03:30:47 INFO - 'cpstartup']}, 03:30:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['a11yr', 03:30:47 INFO - 'ts_paint', 03:30:47 INFO - 'tpaint', 03:30:47 INFO - 'sessionrestore', 03:30:47 INFO - 'sessionrestore_many_windows', 03:30:47 INFO - 'sessionrestore_no_auto_restore', 03:30:47 INFO - 'tabpaint', 03:30:47 INFO - 'cpstartup']}, 03:30:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:30:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:30:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['perf_reftest_singletons']}, 03:30:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['perf_reftest']}, 03:30:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:47 INFO - 'tsvgr_opacity', 03:30:47 INFO - 'tart', 03:30:47 INFO - 'tscrollx', 03:30:47 INFO - 'tsvg_static']}, 03:30:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['tsvgx', 03:30:47 INFO - 'tsvgr_opacity', 03:30:47 INFO - 'tart', 03:30:47 INFO - 'tscrollx', 03:30:47 INFO - 'tsvg_static']}, 03:30:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:30:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'talos_options': ['--disable-stylo'], 03:30:47 INFO - 'tests': ['tp5o']}, 03:30:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:30:47 INFO - 'talos_options': ['--mitmproxy', 03:30:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:47 INFO - '--firstNonBlankPaint'], 03:30:47 INFO - 'tests': ['tp6_google', 03:30:47 INFO - 'tp6_youtube', 03:30:47 INFO - 'tp6_amazon', 03:30:47 INFO - 'tp6_facebook']}, 03:30:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:30:47 INFO - 'talos_options': ['--disable-stylo', 03:30:47 INFO - '--mitmproxy', 03:30:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:47 INFO - '--firstNonBlankPaint'], 03:30:47 INFO - 'tests': ['tp6_google', 03:30:47 INFO - 'tp6_youtube', 03:30:47 INFO - 'tp6_amazon', 03:30:47 INFO - 'tp6_facebook']}, 03:30:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:30:47 INFO - 'talos_options': ['--stylo-threads=1', 03:30:47 INFO - '--mitmproxy', 03:30:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:47 INFO - '--firstNonBlankPaint'], 03:30:47 INFO - 'tests': ['tp6_google', 03:30:47 INFO - 'tp6_youtube', 03:30:47 INFO - 'tp6_amazon', 03:30:47 INFO - 'tp6_facebook']}, 03:30:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'talos_options': ['--xperf_path', 03:30:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:47 INFO - 'tests': ['tp5n']}, 03:30:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:47 INFO - 'talos_options': ['--disable-stylo', 03:30:47 INFO - '--xperf_path', 03:30:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:47 INFO - 'tests': ['tp5n']}}} 03:30:47 INFO - Running post-action listener: _resource_record_post_action 03:30:47 INFO - [mozharness: 2017-10-02 10:30:47.414821Z] Finished populate-webroot step (success) 03:30:47 INFO - [mozharness: 2017-10-02 10:30:47.414911Z] Running create-virtualenv step. 03:30:47 INFO - Running pre-action listener: _resource_record_pre_action 03:30:47 INFO - Running main action method: create_virtualenv 03:30:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:30:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:30:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:30:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:48 INFO - Installing pip...............done. 03:30:48 INFO - Return code: 0 03:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:30:48 INFO - Reading from file tmpfile_stdout 03:30:48 INFO - Output received: 03:30:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:30:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:30:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:30:49 INFO - Downloading/unpacking pip>=1.5 03:30:49 INFO - Running setup.py egg_info for package pip 03:30:49 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:49 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:49 INFO - Installing collected packages: pip 03:30:49 INFO - Found existing installation: pip 1.1 03:30:49 INFO - Uninstalling pip: 03:30:49 INFO - Successfully uninstalled pip 03:30:49 INFO - Running setup.py install for pip 03:30:49 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:49 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:30:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:30:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:30:49 INFO - Successfully installed pip 03:30:49 INFO - Cleaning up... 03:30:49 INFO - Return code: 0 03:30:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:30:49 INFO - Using env: {'DISPLAY': ':0', 03:30:49 INFO - 'HOME': '/home/cltbld', 03:30:49 INFO - 'LANG': 'en_US.UTF-8', 03:30:49 INFO - 'LANGUAGE': 'en_US:en', 03:30:49 INFO - 'LOGNAME': 'cltbld', 03:30:49 INFO - 'MAIL': '/var/mail/cltbld', 03:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:49 INFO - 'MOZ_NO_REMOTE': '1', 03:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:49 INFO - 'NO_EM_RESTART': '1', 03:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:49 INFO - 'PWD': '/builds/slave/test', 03:30:49 INFO - 'SHELL': '/bin/bash', 03:30:49 INFO - 'SHLVL': '1', 03:30:49 INFO - 'TERM': 'linux', 03:30:49 INFO - 'TMOUT': '86400', 03:30:49 INFO - 'USER': 'cltbld', 03:30:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:49 INFO - '_': '/tools/buildbot/bin/python'} 03:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:50 INFO - Downloading/unpacking psutil>=3.1.1 03:30: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 03:30: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 03:30: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 03:30: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 03:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:51 INFO - Installing collected packages: psutil 03:30:51 INFO - Running setup.py install for psutil 03:30:51 INFO - building 'psutil._psutil_linux' extension 03:30:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:30:53 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 03:30:53 INFO - building 'psutil._psutil_posix' extension 03:30:53 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 03:30:53 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 03:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:54 INFO - Successfully installed psutil 03:30:54 INFO - Cleaning up... 03:30:54 INFO - Return code: 0 03:30:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:30:54 INFO - Using env: {'DISPLAY': ':0', 03:30:54 INFO - 'HOME': '/home/cltbld', 03:30:54 INFO - 'LANG': 'en_US.UTF-8', 03:30:54 INFO - 'LANGUAGE': 'en_US:en', 03:30:54 INFO - 'LOGNAME': 'cltbld', 03:30:54 INFO - 'MAIL': '/var/mail/cltbld', 03:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:54 INFO - 'MOZ_NO_REMOTE': '1', 03:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:54 INFO - 'NO_EM_RESTART': '1', 03:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:54 INFO - 'PWD': '/builds/slave/test', 03:30:54 INFO - 'SHELL': '/bin/bash', 03:30:54 INFO - 'SHLVL': '1', 03:30:54 INFO - 'TERM': 'linux', 03:30:54 INFO - 'TMOUT': '86400', 03:30:54 INFO - 'USER': 'cltbld', 03:30:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:54 INFO - '_': '/tools/buildbot/bin/python'} 03:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:55 INFO - Installing collected packages: mozsystemmonitor 03:30:55 INFO - Running setup.py install for mozsystemmonitor 03:30:55 INFO - Successfully installed mozsystemmonitor 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:55 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')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 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')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:57 INFO - warning: no files found matching '*.txt' 03:30:57 INFO - no previously-included directories found matching 'build' 03:30:57 INFO - no previously-included directories found matching 'dist' 03:30:57 INFO - no previously-included directories found matching '.git*' 03:30:57 INFO - Installing collected packages: jsonschema, functools32 03:30:57 INFO - Running setup.py install for functools32 03:30:57 INFO - warning: no files found matching '*.txt' 03:30:57 INFO - no previously-included directories found matching 'build' 03:30:57 INFO - no previously-included directories found matching 'dist' 03:30:57 INFO - no previously-included directories found matching '.git*' 03:30:57 INFO - Successfully installed jsonschema functools32 03:30:57 INFO - Cleaning up... 03:30:57 INFO - Return code: 0 03:30:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:30:57 INFO - Using env: {'DISPLAY': ':0', 03:30:57 INFO - 'HOME': '/home/cltbld', 03:30:57 INFO - 'LANG': 'en_US.UTF-8', 03:30:57 INFO - 'LANGUAGE': 'en_US:en', 03:30:57 INFO - 'LOGNAME': 'cltbld', 03:30:57 INFO - 'MAIL': '/var/mail/cltbld', 03:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:57 INFO - 'MOZ_NO_REMOTE': '1', 03:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:57 INFO - 'NO_EM_RESTART': '1', 03:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:57 INFO - 'PWD': '/builds/slave/test', 03:30:57 INFO - 'SHELL': '/bin/bash', 03:30:57 INFO - 'SHLVL': '1', 03:30:57 INFO - 'TERM': 'linux', 03:30:57 INFO - 'TMOUT': '86400', 03:30:57 INFO - 'USER': 'cltbld', 03:30:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:57 INFO - '_': '/tools/buildbot/bin/python'} 03:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:57 INFO - Cleaning up... 03:30:57 INFO - Return code: 0 03:30:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:30:57 INFO - Using env: {'DISPLAY': ':0', 03:30:57 INFO - 'HOME': '/home/cltbld', 03:30:57 INFO - 'LANG': 'en_US.UTF-8', 03:30:57 INFO - 'LANGUAGE': 'en_US:en', 03:30:57 INFO - 'LOGNAME': 'cltbld', 03:30:57 INFO - 'MAIL': '/var/mail/cltbld', 03:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:57 INFO - 'MOZ_NO_REMOTE': '1', 03:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:57 INFO - 'NO_EM_RESTART': '1', 03:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:57 INFO - 'PWD': '/builds/slave/test', 03:30:57 INFO - 'SHELL': '/bin/bash', 03:30:57 INFO - 'SHLVL': '1', 03:30:57 INFO - 'TERM': 'linux', 03:30:57 INFO - 'TMOUT': '86400', 03:30:57 INFO - 'USER': 'cltbld', 03:30:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:57 INFO - '_': '/tools/buildbot/bin/python'} 03:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:59 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 03:30:59 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 03:30:59 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 03:30:59 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 03:30:59 INFO - Downloading docopt-0.6.1.tar.gz 03:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:59 INFO - Running setup.py install for blobuploader 03:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:59 INFO - Running setup.py install for requests 03:30:59 INFO - Running setup.py install for docopt 03:31:00 INFO - Successfully installed blobuploader requests docopt 03:31:00 INFO - Cleaning up... 03:31:00 INFO - Return code: 0 03:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31: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')]} 03:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:00 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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:31:00 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 03:31:00 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 03:31:00 INFO - Using env: {'DISPLAY': ':0', 03:31:00 INFO - 'HOME': '/home/cltbld', 03:31:00 INFO - 'LANG': 'en_US.UTF-8', 03:31:00 INFO - 'LANGUAGE': 'en_US:en', 03:31:00 INFO - 'LOGNAME': 'cltbld', 03:31:00 INFO - 'MAIL': '/var/mail/cltbld', 03:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:00 INFO - 'MOZ_NO_REMOTE': '1', 03:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:00 INFO - 'NO_EM_RESTART': '1', 03:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:00 INFO - 'PWD': '/builds/slave/test', 03:31:00 INFO - 'SHELL': '/bin/bash', 03:31:00 INFO - 'SHLVL': '1', 03:31:00 INFO - 'TERM': 'linux', 03:31:00 INFO - 'TMOUT': '86400', 03:31:00 INFO - 'USER': 'cltbld', 03:31:00 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:00 INFO - '_': '/tools/buildbot/bin/python'} 03:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:00 INFO - Running setup.py (path:/tmp/pip-nENL3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:00 INFO - Running setup.py (path:/tmp/pip-vG2a9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:00 INFO - Running setup.py (path:/tmp/pip-sTQK7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:00 INFO - Running setup.py (path:/tmp/pip-vOG_Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:00 INFO - Running setup.py (path:/tmp/pip-NwW541-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:00 INFO - Running setup.py (path:/tmp/pip-AIQoWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:00 INFO - Running setup.py (path:/tmp/pip-Ps51ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:00 INFO - Running setup.py (path:/tmp/pip-327sUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:00 INFO - Running setup.py (path:/tmp/pip-M6kebf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:00 INFO - Running setup.py (path:/tmp/pip-KOSGf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:01 INFO - Running setup.py (path:/tmp/pip-nJlpLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:01 INFO - Running setup.py (path:/tmp/pip-YXoXe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:01 INFO - Running setup.py (path:/tmp/pip-xVGv5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:01 INFO - Running setup.py (path:/tmp/pip-VPPVgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:01 INFO - Running setup.py (path:/tmp/pip-zPGLCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:01 INFO - Running setup.py (path:/tmp/pip-VsKJVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:01 INFO - Running setup.py (path:/tmp/pip-tHfMrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:01 INFO - Running setup.py install for manifestparser 03:31:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:01 INFO - Running setup.py install for mozcrash 03:31:01 INFO - Running setup.py install for mozdebug 03:31:01 INFO - Running setup.py install for mozdevice 03:31:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:01 INFO - Running setup.py install for mozfile 03:31:02 INFO - Running setup.py install for mozhttpd 03:31:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozinfo 03:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozInstall 03:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozleak 03:31:02 INFO - Running setup.py install for mozlog 03:31:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for moznetwork 03:31:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozprocess 03:31:02 INFO - Running setup.py install for mozprofile 03:31:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozrunner 03:31:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozscreenshot 03:31:03 INFO - Running setup.py install for moztest 03:31:03 INFO - Running setup.py install for mozversion 03:31:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:03 INFO - Cleaning up... 03:31:03 INFO - Return code: 0 03:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31: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')]} 03:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:03 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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:31:03 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 03:31:03 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 03:31:03 INFO - Using env: {'DISPLAY': ':0', 03:31:03 INFO - 'HOME': '/home/cltbld', 03:31:03 INFO - 'LANG': 'en_US.UTF-8', 03:31:03 INFO - 'LANGUAGE': 'en_US:en', 03:31:03 INFO - 'LOGNAME': 'cltbld', 03:31:03 INFO - 'MAIL': '/var/mail/cltbld', 03:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:03 INFO - 'MOZ_NO_REMOTE': '1', 03:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:03 INFO - 'NO_EM_RESTART': '1', 03:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:03 INFO - 'PWD': '/builds/slave/test', 03:31:03 INFO - 'SHELL': '/bin/bash', 03:31:03 INFO - 'SHLVL': '1', 03:31:03 INFO - 'TERM': 'linux', 03:31:03 INFO - 'TMOUT': '86400', 03:31:03 INFO - 'USER': 'cltbld', 03:31:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:03 INFO - '_': '/tools/buildbot/bin/python'} 03:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:03 INFO - Running setup.py (path:/tmp/pip-Volxk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:03 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)) 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:03 INFO - Running setup.py (path:/tmp/pip-qHPSpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:03 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)) 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:03 INFO - Running setup.py (path:/tmp/pip-1QY95x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:03 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)) 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:03 INFO - Running setup.py (path:/tmp/pip-5pjalh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:03 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)) 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:03 INFO - Running setup.py (path:/tmp/pip-DH5OQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:03 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)) 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:03 INFO - Running setup.py (path:/tmp/pip-Cv0dEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:03 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)) 03:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:03 INFO - Running setup.py (path:/tmp/pip-Zz7w34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:04 INFO - Running setup.py (path:/tmp/pip-qo5J_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:04 INFO - Running setup.py (path:/tmp/pip-MyJs_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:04 INFO - Running setup.py (path:/tmp/pip-N_TeVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:04 INFO - Running setup.py (path:/tmp/pip-LvlzDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:04 INFO - Running setup.py (path:/tmp/pip-KrZ8Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:04 INFO - Running setup.py (path:/tmp/pip-LFksLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:04 INFO - Running setup.py (path:/tmp/pip-WxJw30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:04 INFO - Running setup.py (path:/tmp/pip-kBT1AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:04 INFO - Running setup.py (path:/tmp/pip-PGdfPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:04 INFO - Running setup.py (path:/tmp/pip-Lgs_BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:04 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)) 03:31:04 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)) 03:31:04 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)) 03:31:04 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)) 03:31:04 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)) 03:31:04 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)) 03:31:04 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)) 03:31:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:05 INFO - Downloading blessings-1.6.tar.gz 03:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:05 INFO - Installing collected packages: blessings 03:31:05 INFO - Running setup.py install for blessings 03:31:06 INFO - Successfully installed blessings 03:31:06 INFO - Cleaning up... 03:31:06 INFO - Return code: 0 03:31:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:06 INFO - Reading from file tmpfile_stdout 03:31:06 INFO - Current package versions: 03:31:06 INFO - argparse == 1.2.1 03:31:06 INFO - blessings == 1.6 03:31:06 INFO - blobuploader == 1.2.4 03:31:06 INFO - docopt == 0.6.1 03:31:06 INFO - functools32 == 3.2.3-2 03:31:06 INFO - jsonschema == 2.5.1 03:31:06 INFO - manifestparser == 1.1 03:31:06 INFO - mozInstall == 1.13 03:31:06 INFO - mozcrash == 1.0 03:31:06 INFO - mozdebug == 0.1 03:31:06 INFO - mozdevice == 0.51 03:31:06 INFO - mozfile == 1.2 03:31:06 INFO - mozhttpd == 0.7 03:31:06 INFO - mozinfo == 0.10 03:31:06 INFO - mozleak == 0.1 03:31:06 INFO - mozlog == 3.5 03:31:06 INFO - moznetwork == 0.27 03:31:06 INFO - mozprocess == 0.25 03:31:06 INFO - mozprofile == 0.28 03:31:06 INFO - mozrunner == 6.13 03:31:06 INFO - mozscreenshot == 0.1 03:31:06 INFO - mozsystemmonitor == 0.3 03:31:06 INFO - moztest == 0.8 03:31:06 INFO - mozversion == 1.4 03:31:06 INFO - psutil == 3.1.1 03:31:06 INFO - requests == 1.2.3 03:31:06 INFO - wsgiref == 0.1.2 03:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:06 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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:31:06 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 03:31:06 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 03:31:06 INFO - Using env: {'DISPLAY': ':0', 03:31:06 INFO - 'HOME': '/home/cltbld', 03:31:06 INFO - 'LANG': 'en_US.UTF-8', 03:31:06 INFO - 'LANGUAGE': 'en_US:en', 03:31:06 INFO - 'LOGNAME': 'cltbld', 03:31:06 INFO - 'MAIL': '/var/mail/cltbld', 03:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:06 INFO - 'MOZ_NO_REMOTE': '1', 03:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:06 INFO - 'NO_EM_RESTART': '1', 03:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:06 INFO - 'PWD': '/builds/slave/test', 03:31:06 INFO - 'SHELL': '/bin/bash', 03:31:06 INFO - 'SHLVL': '1', 03:31:06 INFO - 'TERM': 'linux', 03:31:06 INFO - 'TMOUT': '86400', 03:31:06 INFO - 'USER': 'cltbld', 03:31:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:06 INFO - '_': '/tools/buildbot/bin/python'} 03:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:31:07 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)) 03:31:07 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)) 03:31:07 INFO - Installing collected packages: simplejson 03:31:07 INFO - Running setup.py install for simplejson 03:31:07 INFO - building 'simplejson._speedups' extension 03:31:07 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 03:31:08 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 03:31:08 INFO - Successfully installed simplejson 03:31:08 INFO - Cleaning up... 03:31:08 INFO - Return code: 0 03:31:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:08 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')]} 03:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:08 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')]} 03:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:08 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 0x166c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1834b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d99c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', '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 03:31:08 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 03:31:08 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 03:31:08 INFO - Using env: {'DISPLAY': ':0', 03:31:08 INFO - 'HOME': '/home/cltbld', 03:31:08 INFO - 'LANG': 'en_US.UTF-8', 03:31:08 INFO - 'LANGUAGE': 'en_US:en', 03:31:08 INFO - 'LOGNAME': 'cltbld', 03:31:08 INFO - 'MAIL': '/var/mail/cltbld', 03:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:08 INFO - 'MOZ_NO_REMOTE': '1', 03:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:08 INFO - 'NO_EM_RESTART': '1', 03:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:08 INFO - 'PWD': '/builds/slave/test', 03:31:08 INFO - 'SHELL': '/bin/bash', 03:31:08 INFO - 'SHLVL': '1', 03:31:08 INFO - 'TERM': 'linux', 03:31:08 INFO - 'TMOUT': '86400', 03:31:08 INFO - 'USER': 'cltbld', 03:31:08 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:08 INFO - '_': '/tools/buildbot/bin/python'} 03:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:08 INFO - Cleaning up... 03:31:08 INFO - Return code: 0 03:31:08 INFO - Running post-action listener: _resource_record_post_action 03:31:08 INFO - Running post-action listener: _start_resource_monitoring 03:31:09 INFO - Starting resource monitoring. 03:31:09 INFO - [mozharness: 2017-10-02 10:31:09.028152Z] Finished create-virtualenv step (success) 03:31:09 INFO - [mozharness: 2017-10-02 10:31:09.029102Z] Running install step. 03:31:09 INFO - Running pre-action listener: _resource_record_pre_action 03:31:09 INFO - Running main action method: install 03:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:09 INFO - Reading from file tmpfile_stdout 03:31:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:09 INFO - Reading from file tmpfile_stdout 03:31:09 INFO - Output received: 03:31:09 INFO - Usage: mozinstall [options] installer 03:31:09 INFO - Options: 03:31:09 INFO - -h, --help show this help message and exit 03:31:09 INFO - -d DEST, --destination=DEST 03:31:09 INFO - Directory to install application into. [default: 03:31:09 INFO - "/builds/slave/test"] 03:31:09 INFO - --app=APP Application being installed. [default: firefox] 03:31:09 INFO - mkdir: /builds/slave/test/build/application 03:31:09 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'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:31:26 INFO - Reading from file tmpfile_stdout 03:31:26 INFO - Output received: 03:31:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:26 INFO - Running post-action listener: _resource_record_post_action 03:31:26 INFO - [mozharness: 2017-10-02 10:31:26.989660Z] Finished install step (success) 03:31:26 INFO - [mozharness: 2017-10-02 10:31:26.989919Z] Running setup-mitmproxy step. 03:31:26 INFO - Running pre-action listener: _resource_record_pre_action 03:31:26 INFO - Running main action method: setup_mitmproxy 03:31:26 INFO - Skipping: mitmproxy is not required 03:31:26 INFO - Running post-action listener: _resource_record_post_action 03:31:26 INFO - [mozharness: 2017-10-02 10:31:26.991067Z] Finished setup-mitmproxy step (success) 03:31:26 INFO - [mozharness: 2017-10-02 10:31:26.991287Z] Running run-tests step. 03:31:26 INFO - Running pre-action listener: _resource_record_pre_action 03:31:26 INFO - Running pre-action listener: _set_gcov_prefix 03:31:26 INFO - Running main action method: run_tests 03:31:26 WARNING - Try message not found. 03:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:27 INFO - Python 2.7.3 03:31:27 INFO - Return code: 0 03:31:27 INFO - grabbing minidump binary from tooltool 03:31: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')]} 03:31:27 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 0x19d6d60>, '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 0x19d7a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d7ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:27 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 03:31:27 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 03:31:27 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 03:31:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:27 INFO - Return code: 0 03:31:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:27 INFO - ENV: RUST_BACKTRACE is now full 03:31:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:27 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/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 03:31:27 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/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 03:31:27 INFO - Using env: {'DISPLAY': ':0', 03:31:27 INFO - 'HOME': '/home/cltbld', 03:31:27 INFO - 'LANG': 'en_US.UTF-8', 03:31:27 INFO - 'LANGUAGE': 'en_US:en', 03:31:27 INFO - 'LOGNAME': 'cltbld', 03:31:27 INFO - 'MAIL': '/var/mail/cltbld', 03:31:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:27 INFO - 'MOZ_NO_REMOTE': '1', 03:31:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:27 INFO - 'NO_EM_RESTART': '1', 03:31:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:27 INFO - 'PWD': '/builds/slave/test', 03:31:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:27 INFO - 'RUST_BACKTRACE': 'full', 03:31:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:31:27 INFO - 'SHELL': '/bin/bash', 03:31:27 INFO - 'SHLVL': '1', 03:31:27 INFO - 'TERM': 'linux', 03:31:27 INFO - 'TMOUT': '86400', 03:31:27 INFO - 'USER': 'cltbld', 03:31:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:27 INFO - '_': '/tools/buildbot/bin/python'} 03:31:27 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/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 03:31:27 INFO - mozversion application_buildid: 20171002090256 03:31:27 INFO - mozversion application_changeset: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 03:31:27 INFO - mozversion application_display_name: FirefoxNightly 03:31:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:27 INFO - mozversion application_name: Firefox 03:31:27 INFO - mozversion application_remotingname: firefox 03:31:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:27 INFO - mozversion application_vendor: Mozilla 03:31:27 INFO - mozversion application_version: 58.0a1 03:31:27 INFO - mozversion platform_buildid: 20171002090256 03:31:27 INFO - mozversion platform_changeset: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 03:31:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:27 INFO - mozversion platform_version: 58.0a1 03:31:27 INFO - using testdate: 1506940287 03:31:27 INFO - actual date: 1506940287 03:31:27 INFO - starting webserver on 'localhost:60335' 03:31:27 INFO - SUITE-START | Running 2 tests 03:31:27 INFO - TEST-START | dromaeo_css 03:31:27 INFO - Initialising browser for dromaeo_css test... 03:31:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60335/getInfo.html -profile /tmp/tmpsTJYHM/profile 03:31:27 INFO - TEST-INFO | started process 3639 (/builds/slave/test/build/application/firefox/firefox http://localhost:60335/getInfo.html) 03:31:35 INFO - TEST-INFO | 3639: exit 0 03:31:36 INFO - Browser initialized. 03:31:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:36 INFO - Using env: {'DISPLAY': ':0', 03:31:36 INFO - 'HOME': '/home/cltbld', 03:31:36 INFO - 'JSGC_DISABLE_POISONING': '1', 03:31:36 INFO - 'LANG': 'en_US.UTF-8', 03:31:36 INFO - 'LANGUAGE': 'en_US:en', 03:31:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:31:36 INFO - 'LOGNAME': 'cltbld', 03:31:36 INFO - 'MAIL': '/var/mail/cltbld', 03:31:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:36 INFO - 'MOZ_CRASHREPORTER': '1', 03:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:31:36 INFO - 'MOZ_NO_REMOTE': '1', 03:31:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:36 INFO - 'NO_EM_RESTART': '1', 03:31:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:36 INFO - 'PWD': '/builds/slave/test', 03:31:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:36 INFO - 'RUST_BACKTRACE': 'full', 03:31:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:31:36 INFO - 'SHELL': '/bin/bash', 03:31:36 INFO - 'SHLVL': '1', 03:31:36 INFO - 'STYLO_FORCE_DISABLED': '1', 03:31:36 INFO - 'TERM': 'linux', 03:31:36 INFO - 'TMOUT': '86400', 03:31:36 INFO - 'USER': 'cltbld', 03:31:36 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:36 INFO - '_': '/tools/buildbot/bin/python'} 03:31:36 INFO - TEST-INFO | started process 3878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsTJYHM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:36 INFO - PID 3878 | 03:31:36 INFO - PID 3878 | (/builds/slave/test/build/application/firefox/firefox:3928): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:31:36 INFO - PID 3878 | 03:31:47 INFO - PID 3878 | RSS: Main: 141299712 03:31:47 INFO - PID 3878 | 03:34:44 INFO - PID 3878 | Cycle 1(1): loaded http://localhost:60335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60335/tests/dromaeo/cssquery-ext.html) 03:34:45 INFO - PID 3878 | RSS: Main: 142213120 03:34:45 INFO - PID 3878 | 03:37:47 INFO - PID 3878 | Cycle 1(1): loaded http://localhost:60335/tests/dromaeo/cssquery-ext.html (next: http://localhost:60335/tests/dromaeo/cssquery-jquery.html) 03:37:48 INFO - PID 3878 | RSS: Main: 141918208 03:37:48 INFO - PID 3878 | 03:40:49 INFO - PID 3878 | Cycle 1(1): loaded http://localhost:60335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60335/tests/dromaeo/cssquery-mootools.html) 03:40:50 INFO - PID 3878 | RSS: Main: 144412672 03:40:50 INFO - PID 3878 | 03:43:51 INFO - PID 3878 | Cycle 1(1): loaded http://localhost:60335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60335/tests/dromaeo/cssquery-prototype.html) 03:43:52 INFO - PID 3878 | RSS: Main: 143986688 03:43:52 INFO - PID 3878 | 03:46:55 INFO - PID 3878 | Cycle 1(1): loaded http://localhost:60335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60335/tests/dromaeo/cssquery-yui.html) 03:46:55 INFO - PID 3878 | RSS: Main: 147247104 03:46:55 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | Cycle 1(1): loaded http://localhost:60335/tests/dromaeo/cssquery-yui.html (next: http://localhost:60335/tests/dromaeo/cssquery-dojo.html) 03:49:57 INFO - PID 3878 | RSS: Main: 148705280 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | __start_tp_report 03:49:57 INFO - PID 3878 | _x_x_mozilla_page_load 03:49:57 INFO - PID 3878 | _x_x_mozilla_page_load_details 03:49:57 INFO - PID 3878 | |i|pagename|runs| 03:49:57 INFO - PID 3878 | |0;dojo.html;3870.0518372998604;3903.316919539081;3917.451556782049;3926.077371817624;3929.351656976599;6165.445109940105;6214.06788981653;6279.811605651832;6297.118403423518;6385.553011289206;6233.7818176363835;6235.376462353763;6251.749930002806;6256.311805701381;6311.589746666464;5609.214709940612;5631.887362252753;5652.039153343921;5654.067078931971;5680.204771332017;5601.60788744788;5682.602217844753;5689.687067211302;5697.0599851024535;5707.486326230638;5675.631083979528;5746.0806270996645;5748.798792042279;5762.510186634141;5804.303483581976;1002.7311537135736;5556.361018482886;5591.7483713233005;5712.71436428179;5718.199452076713;5579.944200557983;5593.300837395325;5659.5755318351285;5674.375818659944;5688.943110568883;6140.741148064636;6174.44430001302;6188.164597779287;6244.531660125509;6282.842928926768;6734.797956061326;6743.15710536183;6825.761098361583;6843.828904277383;6844.794656160323;6739.157605299338;6753.257141714407;6763.357481039294;6824.21521525026;6848.212455567574;6224.470919971808;6298.559100862942;6315.810525684236;6317.747290108436;6318.241810982619;6884.208316043619;6976.093107895941;6984.965075174591;6990.300969902969;6992.965035174893;6704.161979752531;6755.763548275787;6770.5599136056;6788.355106264897;6809.250982391933;6793;6800.251972283045;6891.655417229119;6892.276310987374;6900.3444672756;6757.966210168917;6777.762778302736;6831.59010459374;6855.5886646801355;6857.897131543031;6640.734370625218;6752.054712340277;6761.425278851353;6788.151481064867;6808.829779255559;4986.90026199474;5022.347094877716;5041.420236672756;5044.495550444926;5049.545540901337;4497.280435130363;4529.705569137996;4535.591796738309;4572.862814115582;4580.656450766206;6095.451409373089;6230.937690623126;6292.370762923671;6366.84082897922;6391.041343798467;6724.4284235840505;6732.124823772878;6732.1921369435;6737.258901520829;6740.696668649923;6334.524910631629;6348.111264422984;6349.142865713162;6359.523035772243;6368.29948705642;5381.246625472437;5521.585881058937;5528.06022976095;5546.63946843462;5552.7223638817895;6870.656467176621;7047.506674532836;7048.295170483013;7151.034610327643;7155.89266161008;6761;6765.830854228585;6781.152355955505;6783.118194634666;6802.421794147355;6930.61881596517;6991.370776630128;7083.220845707071;7098.680559374738;7103.396211321889;6711.0940023096255;6774.220964589135;6799.966000169968;6803.625800581016;6821;6811.761588344384;6813.931860681329;6818.147731533559;6923.4807389447;6931.549449285982;6478.125453063964;6553.5084868634085;6592.17597800275;6635.601863888182;6645.401913827585;6488.870222595616;6589.374009469093;6610.8347291318105;6657.40083392497;6666.100076489805;6448.484121270193;6453.838654033687;6456.580322279036;6544.345565443608;6565.540412171103;6597.1423714916755;6601.867962640817;6679.165104361955;6719.832004199934;6743.52795304324;6399.488040956805;6443.452306553995;6517.185351831021;6520.608763474207;6524.6411447368955 03:49:57 INFO - PID 3878 | |1;ext.html;913.6847787513306;949.1647350331702;971.3297824501095;1015.2030655935088;1020.9897901020987;44948;46040.76979615106;46057.539424605784;46063;46077.76961115194;43274;43377.7831110844;43650.563494365044;43758.781206093925;43888.780556097256;7667.309942105223;7706.267904549059;7765.611719414035;7795.922040779605;7797.76606701797;7638.236176382373;7744.767656970272;7749.147593764681;7753.612319384037;7758.14660387357;8417.158284171564;8574.614142363609;8611.827763444728;8621.913780862205;8627;8495.235428811406;8504.27713644341;8557.27263182627;8558.828823423528;8571.485710857307;8308.29379502743;8346.207110324509;8537.274331681814;8537.701180458716;8541.701040463555;42164;42338;42376;42564.1487170258;42570;3839.2705385976574;3878.0886491674432;3899.961000389988;3904.609539046101;3907.27715372657;35067.1233219169;35335;35345.646543534494;35394.46908296378;35669.82165089184;5396.568274538027;5399.514043736082;5413.593980451482;5440.455954404568;5471.452854714536;240105;240259;240605.79697101578;241343;241899;54931.725341373036;54942.450575493735;54969.72515137479;55005;55352.169717453464;57731.42268577345;57940.42059579435;57969;58041.41958580445;58100.70949645225;17349.21928513195;17507.912460437616;17615.647687046443;17622.207000685;17638.735418968725;14112.082714623517;14121.08212966154;14129.646758831112;14146.22195779242;14245.287735613178;15527.689446211012;15694.195167555878;15801;15882.285297161656;16013.839861601235;5941.940580594139;6110.7861224856915;6200.410960958701;6210.378962103753;6224.533160013018;1064.1965316186383;1072.871255449351;1087.608460954056;1100.2518287564374;1112.5772206561617;26166.345841353737;26242.86878565633;26294.211173664822;26610.334741631614;26619.20142395731;1202.3927916402336;1206.90344772418;1209.4255228766265;1223.2904915149193;1239.8388209532702;13706.177629342272;13828.585142445743;13967.161970281815;14122.858771412155;14312.713745725026;298499;298692;301637;301713;302030;61308.69345653243;62371.376286237464;62965.68517157385;67006.66496667486;67155.66422167858;1519.3011214841076;1534.0948840184344;1540.0374765771394;1550.7983962084857;1552.0687587447667;30843.383132336778;31962.84018579985;32127;32287.51568726424;32350;43256;43447.34828977631;43499;43530;43665.34501982536;246723;246995;247734;249339;250101;35975.10062248465;37157.071073223386;37165.25669486649;37529.812350939166;37547.62452375441;47306.76346618245;47544;48162;48203.75898120487;48503.5149648499;35544.644553554135;35966.46050309195;35986.10034749152;36029.63970360263;36096.63903361038;35382.29235415226;35523.28953420969;35721.64278357287;36424.08939776527;36649.45025824561;41361.58638413698;41398.58601413947;41481;41734.373984389655;41747.58252417558;34464.310713786086;35050.649493505756;35366.64633353634;35504.64495355013;35547.82226088853;25936.351591210372;26655.600165997137;26693.599596005686;26828.329291767863;26973.992210612483 03:49:57 INFO - PID 3878 | |2;jquery.html;618.8607563298258;634.66997161476;636.7071147272253;636.8980963045913;639.9904001439979;23137.537249255005;23335.883320583373;23652.05391784329;23778;24017.279481615536;25110.372240693992;26118.347041323977;26201.868990655068;26254.868725656346;26260.868695656543;6528.934710652892;6629.33706629338;6662.666866656672;6666.100076489684;6673;6426.646534440604;6515.185601799775;6690.029945657877;6707.8658426831435;6710.563813352116;6307.621542707429;6636.104125942984;6674.899876501856;6683.164604424447;6686.197656281253;6584.934150658504;6642.501812364092;6650.168728908887;6653.700583473756;6654.667266636673;6195.814125576195;6203.534734894856;6206.820704066213;6212.534059945522;6217.533684973645;28987.275318117005;29419.85290073536;29969.250768730737;30037.249068773235;30100.397992040256;2233.7207849018873;2249.122842091569;2249.696291000727;2257.638777795561;2260.2993072147688;20461.693074603892;20978.37064888056;20995.475113122142;21042.473938151517;21052.684209736864;2544.1349941019957;2549.592065269548;2592.4426248356503;2612.7648511634043;2628.6057091436246;129177;135000;135234;161846.19076904657;168504.99999999878;16324.918375408284;16983.23575439108;17020.148992550323;17029.574260643334;17161.399351022905;26452.074177403698;26510.46979060408;26695.866520667274;26725.19824405232;26746.598801018;10571.312864663772;10647.25469217163;10794.622188223531;10942.726431839268;10955.068819150461;9651.179649729851;9753.512324383752;9811.067948544876;9816.558254878548;9857.211423086135;9807.460589667495;10060.647877324258;10179.694609161737;10242.334248273839;10391.792164156826;2892.696266891988;2897.8116422432477;2923.4299311634027;2965.2142182321704;3048.314129320885;1031.4791030529534;1047.0681093826502;1056.2975621211808;1057.0961827637414;1058.7459009837582;20731.689024664644;20831.270905518235;20938;20953.26663566768;21340.78659213419;1108.7505311304892;1111.3831823338126;1115.9163062770162;1125.352922069813;1128.0580715102817;11006.229563930448;11317.71705707364;11534.365609891369;11546.826797598043;11603.419829008515;588854;613258;615614;620479;634693;127317.36341318233;129688;131249.3437532806;132862;135863;1070.1920050361928;1211.8184769849327;1228.600704770953;1251.2617555642214;1273.2869593027933;21385.89307053517;21489.785102148777;21519;21548.67676984878;21740.347789566338;61668.69165654143;61889;62235;62335.37664623296;62722.37277627165;75337;76021.6198919024;78554.21445785469;79161.60419197867;80216.3956720874;14706.485273015393;14884.479043233436;14968.775468368201;14990.625234369229;15004.174770387734;23900.40248993789;23901;23938.760612393653;24101.035958562163;24142.63786043246;19304.517387065436;19694.606107878048;19723.60552788965;19760.20959161675;19848.603027939072;17358.82641173572;17519.21163547618;17903.910480447514;17949.551261218574;18100.18549165317;19897.403077907686;19920.70118948246;20215.69676454825;20353.898230508752;20390.79609203889;14620.561383158521;14790.482333118289;14852.480163194236;14883.925580372028;14913;19097.33159339472;19371.225150993803;19468.415947521597;19516.121774520463;19561.315353962542 03:49:57 INFO - PID 3878 | |3;mootools.html;1426.6504706346946;1463.7950686903835;1478.9186594737298;1493.0146103571637;1500.9249537523121;16813.66372672546;17561.47315580533;17570.736438953427;17576.38482653104;17608.119594020296;16913.83086169138;16951.237194326255;16963.74554381682;17096.145192740343;17096.316147354122;2744.217897899099;2750.064977907506;2809.1712944681267;2818.0841226601437;2819.1824370932404;2761.6685997680206;2797.5384061629807;2797.9860100699466;2804.340979869729;2812.170409729135;2768.43247134338;2792.2042217967883;2866.8566571671436;2867.455183515136;2870.3541703116734;2647.1529110684587;2647.8940842366283;2678.022521779556;2680.32991752062;2681.142034548945;2647.8543680097587;2750.573661082535;2756.627855239537;2776.1393967870026;2776.583512473125;16713.331466741314;16827.74758378625;16936.491905242863;16939.068351240676;16976;7987.760367188994;8187.1812818718245;8191.221833925768;8208.958955205246;8227.876581851277;5358.383785864637;5432.13085906257;5606.943930560683;5645.096784514458;5697.6296540724725;2198.340497850654;2200.570888676709;2200.966985495219;2254.9887250563806;2259.7401298850514;31047.37905241905;31309.373812523623;31318.530222046687;31322.37355252905;31410.842945785582;7128.465365097639;7293.416526677853;7304.233055529199;7419.443541734284;7452.664630091659;20474.488137796674;20497.795022049886;20532.897335513226;20581.279655212296;20624.69062964057;8338.583070846433;8548.358873084544;8550.230479256898;8552.700655477029;8562.529060901586;7672.769816905502;7700.807479812937;7784.727534536264;7804.492707973964;7816.218378162252;5569.777208911679;5653.604247702621;5732.394929419769;5808.506276966421;5945.970270148621;1612.6774645070798;1640.7784949031966;1652.6942515634646;1675.103819456585;1697.7623132761423;971.1065819446127;988.515627342597;995.9601615935426;1019.3883669798062;1020.7958408318366;8554.358423118167;8660.783480412914;8670.089640587774;8830.293576513863;8863.822723545622;800.9439339246197;814.8125931035895;818.5702506184301;824.6289169873581;844.0630899701326;5243.8164664236565;5337.066013447631;5749.626274292241;5757.251557297524;5862.413758624103;24505.87747061289;25725.099621513156;25779.35551611187;25961.740382595934;26037.869810650827;24864;25337.366565835633;25689.48621027569;25960.22119336385;25987.22038338853;12249.510019599295;12929.418176181905;13014.869851301555;13074.215547067206;13087.803682944763;9244.95377523108;9507.857382139411;9521.095495927875;9533.761655958657;9591.856122158033;20654.896725516275;20814.791852081285;21544.24595139225;21654.13383464707;21722.56554868862;21786.673199902332;21891.781082189613;21920.89039554792;21964.560708785415;22261.332160035225;13003.47986080584;13016.28410437435;13123.278219697626;13134.73730525365;13136.40886160106;15789.21053947321;15897.364105436116;15971.680566388375;15996.600084997968;16012.759808602646;12214.450349734105;12240.510379585074;12427.627171184879;12497.87502124967;12687.302198379179;11893.76212475763;12085.456154473246;12191.817122743343;12329.568465103679;12380.504779809067;10611.89388106109;10860.294080884718;10870.836937445787;10881.455927203766;10882;7519.1728909818785;7522.734086139615;7602.7339043133225;7637.847243055219;7666.501677390952;7320.743773967885;7414.406847452299;7440.3675687567165;7441.255874412515;7498 03:49:57 INFO - PID 3878 | |4;prototype.html;548.3666365348024;557.7239266563051;575.1832397994848;579.571117373144;583.34665175004;6156.753729850806;6224.190855188819;6263.248410190778;6267.843303917404;6309;6192.907106393408;6205.81382558524;6212.223472065992;6230.688465576714;6235.469985051276;5062.291279220912;5078.4413714491375;5084.822031228908;5105.438401775802;5116.462771409004;4933.481984391641;5043.319151914481;5057.924131138036;5059.822906198284;5078;4954;5007.173816320321;5012.8496145115705;5037.168867136918;5043.470435604264;4943.431505376891;4950.133726597867;4975.800967961277;5005.5995520358465;5014.648974571745;4465.508794032654;4511.774411279423;4546.909061818778;4585;4595.368644131318;6001.909971350433;6058.273007239115;6113.969430152865;6165.383461653843;6174.765046990575;5834;5870.941290587125;5932.466078052953;5950.613210141327;5960.731767070492;6551.93448065518;6624.933750662528;6643.2063342897145;6658.766943157015;6701.93298067018;4950.232713929311;5120.334356533664;5129.871753206163;5159.484051594848;5178.792848286064;6743.4605231581845;6797.728090876359;6857.794266171973;6881.4494840413145;6944.4097251733665;5254.714199323306;5260.316158899395;5287.920681189786;5312.415634280226;5338.839834804962;5379.569634429236;5394.811181608625;5403.81145636018;5420.214068960057;5430.83707488776;5881.852953676107;5886.852828679317;5890.558208134321;5958.6722730249385;5967.850803729942;6655.334466553306;6712.295209003082;6735.046836417482;6738;6764.526483146133;1858.7955324914249;1867.1131212673872;1867.1971052447307;1886.8490520758307;1892.8769629974283;1275.859655437901;1300.9072379201516;1325.4300650720284;1325.6354502511886;1347.9797803032961;6105.267367915879;6133.6319820810895;6196.132541444202;6216.378362163748;6217.875642487125;6621.039949207338;6652.368025037614;6715.932840671629;6759.594424334556;6788.864222715617;6106.4809491192855;6146.416090471398;6187.84530386735;6192.659403732838;6210.565260431817;3555.768875023115;3565.750397472204;3568.107973006748;3570.9285814283567;3571.910702232465;7037.331453511908;7043.119610048744;7045.1898031727005;7060.54106483077;7092.290770922867;6889.931100689029;6908.412784913338;6918.619475928772;6920.273371295942;6957.304269573002;6753.729850805913;6970.546914450544;6991.510594258353;7047.859042819115;7062.823429414203;6601.669916504252;6684.43182329488;6691.397774200345;6733.023711561698;6769.3753499158865;6625.879718490037;6679.56582822115;6698.430633396216;6742.235683369795;6787.694553745192;7035.401990830836;7047.6828542714675;7053.259407762111;7090.220075791762;7143.6428178591905;5186.196139598368;5265.341832270966;5279.445658205833;5290.206469029523;5296.364436267672;6493.448056915215;6592.538522303393;6719;6722.2605513394465;6798.184217893884;6453.870922581616;6467.708953097216;6543.967280163569;6598.307177746459;6611.603303801595;6483.735671544004;6519.185101862267;6534.607923524603;6593.142891424084;6620.271770105188;6260.655663938345;6368.777092801915;6408.551401402044;6421.8394540135005;6480.513961453004;6511.674416279262;6609.372109649576;6638.701258443478;6698.966505167443;6712.731490740511;6360.173177486897;6424.743010279723;6460.353964603502;6470.320616335405;6478.838029049311 03:49:57 INFO - PID 3878 | |5;yui.html;951.5765484359463;983.9311248212625;991.6380521109797;999.2755252441981;1012.9189664826814;21004.26485073023;21515.67726484102;21569.1372345106;21680.674789878165;21826.89086554569;19786.505337366572;19880.602387952233;20055.59888802227;20067.498312542193;20121.69817452736;1048.1457612046177;1067.2475904487317;1069.5561342043043;1069.5668254356997;1075.7095584192264;1053.5785685725693;1079.1906070447164;1079.2930630437038;1083.2579682917226;1084.4740300954031;1132.2923173016864;1138.5787258714288;1140.8060629692973;1143.262595625821;1143.4454289669504;1131.1064259235195;1135.835303880941;1138.4250953268588;1138.5332013874272;1140.5665846978095;829.0383155539545;834.7954751085962;835.3943391041507;836.1220718245818;838.1743982177611;20991.26530571438;21722.891385543127;21914.23300184502;21936.45158871025;22513;23061.19285824988;23175.188868389527;23636.881815590812;23647.527049459088;24490.755092449024;18419.355322563646;18834;18888.71666924997;18949.052547372576;18955.24179032837;3929.9017524562114;3986.960130398688;3988.481497405348;3989.4414781930554;3990.102226998931;159984.20007900003;163670.18164909218;163764;165539.17230413892;167385;16587.585310367336;16810.243539040526;16844.157792110345;16948.322067117177;17335.479935601954;33229;35234.647653523134;35493.290134197174;35599.82200088983;35621;9269.768255793659;9427.528623568795;9542.188913942255;9555;9604.75988100289;4663.626909847204;4757.738324392191;4757.809687612456;4759.619230461555;4767.547083027107;6207.96896015517;6222.471089957405;6274.435300822856;6320.146780184708;6331.27190373113;1162.598903378333;1181.468339247342;1200.9099317551218;1206.6199147268583;1209.7640960012889;736.1681300130817;744.765398899345;748.3526749361763;766.9961650191714;768.7463137164722;12618.747625047448;12879.098463107492;12921.612351629467;13391.732165356638;13406.731865362639;737.8856277277031;748.2143749063462;760.3271105072051;761.432732614206;767.7044337929938;6262.34245404226;6290.276618188876;6316.968415157895;6337.873242535124;6390.265119511223;158755;158895.20552397394;158975;161712;164150;135521;138024;139622.30188849193;140319.29840350733;141436;123149;124072.37963810124;124204.37897810453;124764.64994946876;125796.37101814432;11855.407229638311;12004.519819207135;12019.459124339252;12063.517459301529;12139.635810925687;57956.4204357951;58165.70917145387;58172.70913645405;58330.4166958325;58564.707176463846;72316.63841680757;72965.6351718238;73722.26277737154;73960;74441;17270.222839972485;17830;17851.46445606634;17978;18082.367117150836;18624.16191271369;18745.343912963526;18761.718574221126;18842.623147537248;18975.620487589895;15616.687666246838;15728.05631662104;15820.446284379992;15892.602684932506;15906.363745450053;16297.918510407371;16335.836641633432;16355.59111022234;16499.422520211734;16503;16721.996680199227;16741.91629041847;16778.664426711643;16886.74669879928;16986.320547177973;12256.816147757612;12564.994800415761;12571.497140114294;12583.433745481292;12692;12035.157538972187;12168.756624867276;12510.374481276081;12529.686757831127;12649.87350126487 03:49:57 INFO - PID 3878 | __end_tp_report 03:49:57 INFO - PID 3878 | __start_cc_report 03:49:57 INFO - PID 3878 | _x_x_mozilla_cycle_collect,254 03:49:57 INFO - PID 3878 | __end_cc_report 03:49:57 INFO - PID 3878 | __startTimestamp1506941397456__endTimestamp 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | ------- Summary: start ------- 03:49:57 INFO - PID 3878 | Number of tests: 6 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | [#0] dojo.html Cycles:165 Average:6238.79 Median:6517.19 stddev:836.00 (12.8%) stddev-sans-first:817.65 03:49:57 INFO - PID 3878 | Values: 3870.1 3903.3 3917.5 3926.1 3929.4 6165.4 6214.1 6279.8 6297.1 6385.6 6233.8 6235.4 6251.7 6256.3 6311.6 5609.2 5631.9 5652.0 5654.1 5680.2 5601.6 5682.6 5689.7 5697.1 5707.5 5675.6 5746.1 5748.8 5762.5 5804.3 1002.7 5556.4 5591.7 5712.7 5718.2 5579.9 5593.3 5659.6 5674.4 5688.9 6140.7 6174.4 6188.2 6244.5 6282.8 6734.8 6743.2 6825.8 6843.8 6844.8 6739.2 6753.3 6763.4 6824.2 6848.2 6224.5 6298.6 6315.8 6317.7 6318.2 6884.2 6976.1 6985.0 6990.3 6993.0 6704.2 6755.8 6770.6 6788.4 6809.3 6793.0 6800.3 6891.7 6892.3 6900.3 6758.0 6777.8 6831.6 6855.6 6857.9 6640.7 6752.1 6761.4 6788.2 6808.8 4986.9 5022.3 5041.4 5044.5 5049.5 4497.3 4529.7 4535.6 4572.9 4580.7 6095.5 6230.9 6292.4 6366.8 6391.0 6724.4 6732.1 6732.2 6737.3 6740.7 6334.5 6348.1 6349.1 6359.5 6368.3 5381.2 5521.6 5528.1 5546.6 5552.7 6870.7 7047.5 7048.3 7151.0 7155.9 6761.0 6765.8 6781.2 6783.1 6802.4 6930.6 6991.4 7083.2 7098.7 7103.4 6711.1 6774.2 6800.0 6803.6 6821.0 6811.8 6813.9 6818.1 6923.5 6931.5 6478.1 6553.5 6592.2 6635.6 6645.4 6488.9 6589.4 6610.8 6657.4 6666.1 6448.5 6453.8 6456.6 6544.3 6565.5 6597.1 6601.9 6679.2 6719.8 6743.5 6399.5 6443.5 6517.2 6520.6 6524.6 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | [#1] ext.html Cycles:180 Average:44963.06 Median:37538.72 stddev:68830.06 (183.4%) stddev-sans-first:68943.68 03:49:57 INFO - PID 3878 | Values: 913.7 949.2 971.3 1015.2 1021.0 44948.0 46040.8 46057.5 46063.0 46077.8 43274.0 43377.8 43650.6 43758.8 43888.8 7667.3 7706.3 7765.6 7795.9 7797.8 7638.2 7744.8 7749.1 7753.6 7758.1 8417.2 8574.6 8611.8 8621.9 8627.0 8495.2 8504.3 8557.3 8558.8 8571.5 8308.3 8346.2 8537.3 8537.7 8541.7 42164.0 42338.0 42376.0 42564.1 42570.0 3839.3 3878.1 3900.0 3904.6 3907.3 35067.1 35335.0 35345.6 35394.5 35669.8 5396.6 5399.5 5413.6 5440.5 5471.5 240105.0 240259.0 240605.8 241343.0 241899.0 54931.7 54942.5 54969.7 55005.0 55352.2 57731.4 57940.4 57969.0 58041.4 58100.7 17349.2 17507.9 17615.6 17622.2 17638.7 14112.1 14121.1 14129.6 14146.2 14245.3 15527.7 15694.2 15801.0 15882.3 16013.8 5941.9 6110.8 6200.4 6210.4 6224.5 1064.2 1072.9 1087.6 1100.3 1112.6 26166.3 26242.9 26294.2 26610.3 26619.2 1202.4 1206.9 1209.4 1223.3 1239.8 13706.2 13828.6 13967.2 14122.9 14312.7 298499.0 298692.0 301637.0 301713.0 302030.0 61308.7 62371.4 62965.7 67006.7 67155.7 1519.3 1534.1 1540.0 1550.8 1552.1 30843.4 31962.8 32127.0 32287.5 32350.0 43256.0 43447.3 43499.0 43530.0 43665.3 246723.0 246995.0 247734.0 249339.0 250101.0 35975.1 37157.1 37165.3 37529.8 37547.6 47306.8 47544.0 48162.0 48203.8 48503.5 35544.6 35966.5 35986.1 36029.6 36096.6 35382.3 35523.3 35721.6 36424.1 36649.5 41361.6 41398.6 41481.0 41734.4 41747.6 34464.3 35050.6 35366.6 35504.6 35547.8 25936.4 26655.6 26693.6 26828.3 26974.0 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | [#2] jquery.html Cycles:180 Average:39873.53 Median:2249.41 stddev:102631.52 (4562.6%) stddev-sans-first:102877.11 03:49:57 INFO - PID 3878 | Values: 618.9 634.7 636.7 636.9 640.0 23137.5 23335.9 23652.1 23778.0 24017.3 25110.4 26118.3 26201.9 26254.9 26260.9 6528.9 6629.3 6662.7 6666.1 6673.0 6426.6 6515.2 6690.0 6707.9 6710.6 6307.6 6636.1 6674.9 6683.2 6686.2 6584.9 6642.5 6650.2 6653.7 6654.7 6195.8 6203.5 6206.8 6212.5 6217.5 28987.3 29419.9 29969.3 30037.2 30100.4 2233.7 2249.1 2249.7 2257.6 2260.3 20461.7 20978.4 20995.5 21042.5 21052.7 2544.1 2549.6 2592.4 2612.8 2628.6 129177.0 135000.0 135234.0 161846.2 168505.0 16324.9 16983.2 17020.1 17029.6 17161.4 26452.1 26510.5 26695.9 26725.2 26746.6 10571.3 10647.3 10794.6 10942.7 10955.1 9651.2 9753.5 9811.1 9816.6 9857.2 9807.5 10060.6 10179.7 10242.3 10391.8 2892.7 2897.8 2923.4 2965.2 3048.3 1031.5 1047.1 1056.3 1057.1 1058.7 20731.7 20831.3 20938.0 20953.3 21340.8 1108.8 1111.4 1115.9 1125.4 1128.1 11006.2 11317.7 11534.4 11546.8 11603.4 588854.0 613258.0 615614.0 620479.0 634693.0 127317.4 129688.0 131249.3 132862.0 135863.0 1070.2 1211.8 1228.6 1251.3 1273.3 21385.9 21489.8 21519.0 21548.7 21740.3 61668.7 61889.0 62235.0 62335.4 62722.4 75337.0 76021.6 78554.2 79161.6 80216.4 14706.5 14884.5 14968.8 14990.6 15004.2 23900.4 23901.0 23938.8 24101.0 24142.6 19304.5 19694.6 19723.6 19760.2 19848.6 17358.8 17519.2 17903.9 17949.6 18100.2 19897.4 19920.7 20215.7 20353.9 20390.8 14620.6 14790.5 14852.5 14883.9 14913.0 19097.3 19371.2 19468.4 19516.1 19561.3 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | [#3] mootools.html Cycles:180 Average:10490.97 Median:2679.18 stddev:7923.97 (295.8%) stddev-sans-first:7916.94 03:49:57 INFO - PID 3878 | Values: 1426.7 1463.8 1478.9 1493.0 1500.9 16813.7 17561.5 17570.7 17576.4 17608.1 16913.8 16951.2 16963.7 17096.1 17096.3 2744.2 2750.1 2809.2 2818.1 2819.2 2761.7 2797.5 2798.0 2804.3 2812.2 2768.4 2792.2 2866.9 2867.5 2870.4 2647.2 2647.9 2678.0 2680.3 2681.1 2647.9 2750.6 2756.6 2776.1 2776.6 16713.3 16827.7 16936.5 16939.1 16976.0 7987.8 8187.2 8191.2 8209.0 8227.9 5358.4 5432.1 5606.9 5645.1 5697.6 2198.3 2200.6 2201.0 2255.0 2259.7 31047.4 31309.4 31318.5 31322.4 31410.8 7128.5 7293.4 7304.2 7419.4 7452.7 20474.5 20497.8 20532.9 20581.3 20624.7 8338.6 8548.4 8550.2 8552.7 8562.5 7672.8 7700.8 7784.7 7804.5 7816.2 5569.8 5653.6 5732.4 5808.5 5946.0 1612.7 1640.8 1652.7 1675.1 1697.8 971.1 988.5 996.0 1019.4 1020.8 8554.4 8660.8 8670.1 8830.3 8863.8 800.9 814.8 818.6 824.6 844.1 5243.8 5337.1 5749.6 5757.3 5862.4 24505.9 25725.1 25779.4 25961.7 26037.9 24864.0 25337.4 25689.5 25960.2 25987.2 12249.5 12929.4 13014.9 13074.2 13087.8 9245.0 9507.9 9521.1 9533.8 9591.9 20654.9 20814.8 21544.2 21654.1 21722.6 21786.7 21891.8 21920.9 21964.6 22261.3 13003.5 13016.3 13123.3 13134.7 13136.4 15789.2 15897.4 15971.7 15996.6 16012.8 12214.5 12240.5 12427.6 12497.9 12687.3 11893.8 12085.5 12191.8 12329.6 12380.5 10611.9 10860.3 10870.8 10881.5 10882.0 7519.2 7522.7 7602.7 7637.8 7666.5 7320.7 7414.4 7440.4 7441.3 7498.0 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | [#4] prototype.html Cycles:180 Average:5647.69 Median:6211.39 stddev:1561.20 (25.1%) stddev-sans-first:1517.94 03:49:57 INFO - PID 3878 | Values: 548.4 557.7 575.2 579.6 583.3 6156.8 6224.2 6263.2 6267.8 6309.0 6192.9 6205.8 6212.2 6230.7 6235.5 5062.3 5078.4 5084.8 5105.4 5116.5 4933.5 5043.3 5057.9 5059.8 5078.0 4954.0 5007.2 5012.8 5037.2 5043.5 4943.4 4950.1 4975.8 5005.6 5014.6 4465.5 4511.8 4546.9 4585.0 4595.4 6001.9 6058.3 6114.0 6165.4 6174.8 5834.0 5870.9 5932.5 5950.6 5960.7 6551.9 6624.9 6643.2 6658.8 6701.9 4950.2 5120.3 5129.9 5159.5 5178.8 6743.5 6797.7 6857.8 6881.4 6944.4 5254.7 5260.3 5287.9 5312.4 5338.8 5379.6 5394.8 5403.8 5420.2 5430.8 5881.9 5886.9 5890.6 5958.7 5967.9 6655.3 6712.3 6735.0 6738.0 6764.5 1858.8 1867.1 1867.2 1886.8 1892.9 1275.9 1300.9 1325.4 1325.6 1348.0 6105.3 6133.6 6196.1 6216.4 6217.9 6621.0 6652.4 6715.9 6759.6 6788.9 6106.5 6146.4 6187.8 6192.7 6210.6 3555.8 3565.8 3568.1 3570.9 3571.9 7037.3 7043.1 7045.2 7060.5 7092.3 6889.9 6908.4 6918.6 6920.3 6957.3 6753.7 6970.5 6991.5 7047.9 7062.8 6601.7 6684.4 6691.4 6733.0 6769.4 6625.9 6679.6 6698.4 6742.2 6787.7 7035.4 7047.7 7053.3 7090.2 7143.6 5186.2 5265.3 5279.4 5290.2 5296.4 6493.4 6592.5 6719.0 6722.3 6798.2 6453.9 6467.7 6544.0 6598.3 6611.6 6483.7 6519.2 6534.6 6593.1 6620.3 6260.7 6368.8 6408.6 6421.8 6480.5 6511.7 6609.4 6638.7 6699.0 6712.7 6360.2 6424.7 6460.4 6470.3 6478.8 03:49:57 INFO - PID 3878 | 03:49:57 INFO - PID 3878 | [#5] yui.html Cycles:180 Average:29240.17 Median:18250.86 stddev:44713.25 (245.0%) stddev-sans-first:44788.24 03:49:57 INFO - PID 3878 | Values: 951.6 983.9 991.6 999.3 1012.9 21004.3 21515.7 21569.1 21680.7 21826.9 19786.5 19880.6 20055.6 20067.5 20121.7 1048.1 1067.2 1069.6 1069.6 1075.7 1053.6 1079.2 1079.3 1083.3 1084.5 1132.3 1138.6 1140.8 1143.3 1143.4 1131.1 1135.8 1138.4 1138.5 1140.6 829.0 834.8 835.4 836.1 838.2 20991.3 21722.9 21914.2 21936.5 22513.0 23061.2 23175.2 23636.9 23647.5 24490.8 18419.4 18834.0 18888.7 18949.1 18955.2 3929.9 3987.0 3988.5 3989.4 3990.1 159984.2 163670.2 163764.0 165539.2 167385.0 16587.6 16810.2 16844.2 16948.3 17335.5 33229.0 35234.6 35493.3 35599.8 35621.0 9269.8 9427.5 9542.2 9555.0 9604.8 4663.6 4757.7 4757.8 4759.6 4767.5 6208.0 6222.5 6274.4 6320.1 6331.3 1162.6 1181.5 1200.9 1206.6 1209.8 736.2 744.8 748.4 767.0 768.7 12618.7 12879.1 12921.6 13391.7 13406.7 737.9 748.2 760.3 761.4 767.7 6262.3 6290.3 6317.0 6337.9 6390.3 158755.0 158895.2 158975.0 161712.0 164150.0 135521.0 138024.0 139622.3 140319.3 141436.0 123149.0 124072.4 124204.4 124764.6 125796.4 11855.4 12004.5 12019.5 12063.5 12139.6 57956.4 58165.7 58172.7 58330.4 58564.7 72316.6 72965.6 73722.3 73960.0 74441.0 17270.2 17830.0 17851.5 17978.0 18082.4 18624.2 18745.3 18761.7 18842.6 18975.6 15616.7 15728.1 15820.4 15892.6 15906.4 16297.9 16335.8 16355.6 16499.4 16503.0 16722.0 16741.9 16778.7 16886.7 16986.3 12256.8 12565.0 12571.5 12583.4 12692.0 12035.2 12168.8 12510.4 12529.7 12649.9 03:49:57 INFO - PID 3878 | -------- Summary: end -------- 03:49:57 INFO - PID 3878 | 03:49:57 INFO - TEST-INFO | 3878: exit 0 03:49:57 INFO - TEST-OK | dromaeo_css | took 1110571ms 03:49:57 INFO - TEST-START | kraken 03:49:57 INFO - Initialising browser for kraken test... 03:49:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60335/getInfo.html -profile /tmp/tmpPuhQsL/profile 03:49:57 INFO - TEST-INFO | started process 4255 (/builds/slave/test/build/application/firefox/firefox http://localhost:60335/getInfo.html) 03:50:03 INFO - TEST-INFO | 4255: exit 0 03:50:03 INFO - Browser initialized. 03:50:03 INFO - Running cycle 1/1 for kraken test... 03:50:03 INFO - Using env: {'DISPLAY': ':0', 03:50:03 INFO - 'HOME': '/home/cltbld', 03:50:03 INFO - 'JSGC_DISABLE_POISONING': '1', 03:50:03 INFO - 'LANG': 'en_US.UTF-8', 03:50:03 INFO - 'LANGUAGE': 'en_US:en', 03:50:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:50:03 INFO - 'LOGNAME': 'cltbld', 03:50:03 INFO - 'MAIL': '/var/mail/cltbld', 03:50:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:03 INFO - 'MOZ_CRASHREPORTER': '1', 03:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:50:03 INFO - 'MOZ_NO_REMOTE': '1', 03:50:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:03 INFO - 'NO_EM_RESTART': '1', 03:50:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:03 INFO - 'PWD': '/builds/slave/test', 03:50:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:03 INFO - 'RUST_BACKTRACE': 'full', 03:50:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:50:03 INFO - 'SHELL': '/bin/bash', 03:50:03 INFO - 'SHLVL': '1', 03:50:03 INFO - 'STYLO_FORCE_DISABLED': '1', 03:50:03 INFO - 'TERM': 'linux', 03:50:03 INFO - 'TMOUT': '86400', 03:50:03 INFO - 'USER': 'cltbld', 03:50:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211', 03:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:03 INFO - '_': '/tools/buildbot/bin/python'} 03:50:03 INFO - TEST-INFO | started process 4497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPuhQsL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:04 INFO - PID 4497 | 03:50:04 INFO - PID 4497 | (/builds/slave/test/build/application/firefox/firefox:4546): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:50:04 INFO - PID 4497 | 03:50:14 INFO - PID 4497 | RSS: Main: 144945152 03:50:14 INFO - PID 4497 | 03:50:17 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60335/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:17 INFO - PID 4497 | RSS: Main: 150982656 03:50:17 INFO - PID 4497 | 03:50:20 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60335/tests/kraken/driver.html?testName=audio-dft) 03:50:21 INFO - PID 4497 | RSS: Main: 151769088 03:50:21 INFO - PID 4497 | 03:50:24 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60335/tests/kraken/driver.html?testName=audio-fft) 03:50:24 INFO - PID 4497 | RSS: Main: 148058112 03:50:24 INFO - PID 4497 | 03:50:26 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60335/tests/kraken/driver.html?testName=audio-oscillator) 03:50:27 INFO - PID 4497 | RSS: Main: 149184512 03:50:27 INFO - PID 4497 | 03:50:29 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:29 INFO - PID 4497 | RSS: Main: 148885504 03:50:29 INFO - PID 4497 | 03:50:32 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60335/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:33 INFO - PID 4497 | RSS: Main: 149213184 03:50:33 INFO - PID 4497 | 03:50:37 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60335/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:37 INFO - PID 4497 | RSS: Main: 150921216 03:50:37 INFO - PID 4497 | 03:50:40 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60335/tests/kraken/driver.html?testName=json-parse-financial) 03:50:41 INFO - PID 4497 | RSS: Main: 151703552 03:50:41 INFO - PID 4497 | 03:50:42 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:43 INFO - PID 4497 | RSS: Main: 151617536 03:50:43 INFO - PID 4497 | 03:50:44 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:45 INFO - PID 4497 | RSS: Main: 151760896 03:50:45 INFO - PID 4497 | 03:50:47 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:48 INFO - PID 4497 | RSS: Main: 148668416 03:50:48 INFO - PID 4497 | 03:50:50 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:51 INFO - PID 4497 | RSS: Main: 148500480 03:50:51 INFO - PID 4497 | 03:50:53 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:54 INFO - PID 4497 | RSS: Main: 149549056 03:50:54 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | Cycle 1(1): loaded http://localhost:60335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60335/tests/kraken/driver.html?testName=ai-astar) 03:50:56 INFO - PID 4497 | RSS: Main: 150880256 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | __start_tp_report 03:50:56 INFO - PID 4497 | _x_x_mozilla_page_load 03:50:56 INFO - PID 4497 | _x_x_mozilla_page_load_details 03:50:56 INFO - PID 4497 | |i|pagename|runs| 03:50:56 INFO - PID 4497 | |0;ai-astar;106;104;104;104;104;106;107;106;105;105 03:50:56 INFO - PID 4497 | |1;audio-beat-detection;112;113;112;113;111;112;111;111;122;111 03:50:56 INFO - PID 4497 | |2;audio-dft;163;163;161;163;164;161;163;162;163;171 03:50:56 INFO - PID 4497 | |3;audio-fft;74;74;74;74;74;74;73;74;73;81 03:50:56 INFO - PID 4497 | |4;audio-oscillator;78;77;78;77;77;77;76;79;76;77 03:50:56 INFO - PID 4497 | |5;imaging-gaussian-blur;111;112;111;112;115;112;111;112;112;113 03:50:56 INFO - PID 4497 | |6;imaging-darkroom;149;150;152;150;152;151;160;151;150;151 03:50:56 INFO - PID 4497 | |7;imaging-desaturate;98;94;94;94;94;94;94;95;94;93 03:50:56 INFO - PID 4497 | |8;json-parse-financial;44;47;43;52;44;48;44;46;43;43 03:50:56 INFO - PID 4497 | |9;json-stringify-tinderbox;38;37;37;37;36;37;37;37;37;37 03:50:56 INFO - PID 4497 | |10;stanford-crypto-aes;71;70;72;71;70;72;70;74;71;72 03:50:56 INFO - PID 4497 | |11;stanford-crypto-ccm;103;103;103;109;105;107;105;110;107;110 03:50:56 INFO - PID 4497 | |12;stanford-crypto-pbkdf2;148;144;154;150;157;146;152;145;148;144 03:50:56 INFO - PID 4497 | |13;stanford-crypto-sha256-iterative;57;58;57;59;56;60;57;65;59;58 03:50:56 INFO - PID 4497 | __end_tp_report 03:50:56 INFO - PID 4497 | __start_cc_report 03:50:56 INFO - PID 4497 | _x_x_mozilla_cycle_collect,719 03:50:56 INFO - PID 4497 | __end_cc_report 03:50:56 INFO - PID 4497 | __startTimestamp1506941456261__endTimestamp 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | ------- Summary: start ------- 03:50:56 INFO - PID 4497 | Number of tests: 14 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#0] ai-astar Cycles:10 Average:105.10 Median:105.50 stddev:1.10 (1.0%) stddev-sans-first:1.12 03:50:56 INFO - PID 4497 | Values: 106.0 104.0 104.0 104.0 104.0 106.0 107.0 106.0 105.0 105.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#1] audio-beat-detection Cycles:10 Average:112.80 Median:112.00 stddev:3.33 (3.0%) stddev-sans-first:3.52 03:50:56 INFO - PID 4497 | Values: 112.0 113.0 112.0 113.0 111.0 112.0 111.0 111.0 122.0 111.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.84 (1.7%) stddev-sans-first:3.00 03:50:56 INFO - PID 4497 | Values: 163.0 163.0 161.0 163.0 164.0 161.0 163.0 162.0 163.0 171.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#3] audio-fft Cycles:10 Average:74.50 Median:74.00 stddev:2.32 (3.1%) stddev-sans-first:2.46 03:50:56 INFO - PID 4497 | Values: 74.0 74.0 74.0 74.0 74.0 74.0 73.0 74.0 73.0 81.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.00 stddev:0.92 (1.2%) stddev-sans-first:0.93 03:50:56 INFO - PID 4497 | Values: 78.0 77.0 78.0 77.0 77.0 77.0 76.0 79.0 76.0 77.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#5] imaging-gaussian-blur Cycles:10 Average:112.10 Median:112.00 stddev:1.20 (1.1%) stddev-sans-first:1.20 03:50:56 INFO - PID 4497 | Values: 111.0 112.0 111.0 112.0 115.0 112.0 111.0 112.0 112.0 113.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:3.10 (2.1%) stddev-sans-first:3.14 03:50:56 INFO - PID 4497 | Values: 149.0 150.0 152.0 150.0 152.0 151.0 160.0 151.0 150.0 151.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:0.50 03:50:56 INFO - PID 4497 | Values: 98.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#8] json-parse-financial Cycles:10 Average:45.40 Median:45.00 stddev:2.91 (6.5%) stddev-sans-first:3.05 03:50:56 INFO - PID 4497 | Values: 44.0 47.0 43.0 52.0 44.0 48.0 44.0 46.0 43.0 43.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.47 (1.3%) stddev-sans-first:0.33 03:50:56 INFO - PID 4497 | Values: 38.0 37.0 37.0 37.0 36.0 37.0 37.0 37.0 37.0 37.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#10] stanford-crypto-aes Cycles:10 Average:71.30 Median:71.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 03:50:56 INFO - PID 4497 | Values: 71.0 70.0 72.0 71.0 70.0 72.0 70.0 74.0 71.0 72.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#11] stanford-crypto-ccm Cycles:10 Average:106.20 Median:107.00 stddev:2.82 (2.6%) stddev-sans-first:2.74 03:50:56 INFO - PID 4497 | Values: 103.0 103.0 103.0 109.0 105.0 107.0 105.0 110.0 107.0 110.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:149.00 stddev:4.42 (3.0%) stddev-sans-first:4.68 03:50:56 INFO - PID 4497 | Values: 148.0 144.0 154.0 150.0 157.0 146.0 152.0 145.0 148.0 144.0 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.60 Median:58.50 stddev:2.55 (4.4%) stddev-sans-first:2.64 03:50:56 INFO - PID 4497 | Values: 57.0 58.0 57.0 59.0 56.0 60.0 57.0 65.0 59.0 58.0 03:50:56 INFO - PID 4497 | -------- Summary: end -------- 03:50:56 INFO - PID 4497 | 03:50:56 INFO - PID 4497 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:50:56 INFO - TEST-INFO | 4497: exit 0 03:50:56 INFO - TEST-OK | kraken | took 58989ms 03:50:56 INFO - SUITE-END | took 1169s 03:50:57 INFO - Completed test suite (00:19:30) 03:50:57 INFO - javascript benchmark 03:50:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9125.21726068899, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3870.0518372998604, 3903.316919539081, 3917.451556782049, 3926.077371817624, 3929.351656976599, 6165.445109940105, 6214.06788981653, 6279.811605651832, 6297.118403423518, 6385.553011289206, 6233.7818176363835, 6235.376462353763, 6251.749930002806, 6256.311805701381, 6311.589746666464, 5609.214709940612, 5631.887362252753, 5652.039153343921, 5654.067078931971, 5680.204771332017, 5601.60788744788, 5682.602217844753, 5689.687067211302, 5697.0599851024535, 5707.486326230638, 5675.631083979528, 5746.0806270996645, 5748.798792042279, 5762.510186634141, 5804.303483581976, 1002.7311537135736, 5556.361018482886, 5591.7483713233005, 5712.71436428179, 5718.199452076713, 5579.944200557983, 5593.300837395325, 5659.5755318351285, 5674.375818659944, 5688.943110568883, 6140.741148064636, 6174.44430001302, 6188.164597779287, 6244.531660125509, 6282.842928926768, 6734.797956061326, 6743.15710536183, 6825.761098361583, 6843.828904277383, 6844.794656160323, 6739.157605299338, 6753.257141714407, 6763.357481039294, 6824.21521525026, 6848.212455567574, 6224.470919971808, 6298.559100862942, 6315.810525684236, 6317.747290108436, 6318.241810982619, 6884.208316043619, 6976.093107895941, 6984.965075174591, 6990.300969902969, 6992.965035174893, 6704.161979752531, 6755.763548275787, 6770.5599136056, 6788.355106264897, 6809.250982391933, 6793.0, 6800.251972283045, 6891.655417229119, 6892.276310987374, 6900.3444672756, 6757.966210168917, 6777.762778302736, 6831.59010459374, 6855.5886646801355, 6857.897131543031, 6640.734370625218, 6752.054712340277, 6761.425278851353, 6788.151481064867, 6808.829779255559, 4986.90026199474, 5022.347094877716, 5041.420236672756, 5044.495550444926, 5049.545540901337, 4497.280435130363, 4529.705569137996, 4535.591796738309, 4572.862814115582, 4580.656450766206, 6095.451409373089, 6230.937690623126, 6292.370762923671, 6366.84082897922, 6391.041343798467, 6724.4284235840505, 6732.124823772878, 6732.1921369435, 6737.258901520829, 6740.696668649923, 6334.524910631629, 6348.111264422984, 6349.142865713162, 6359.523035772243, 6368.29948705642, 5381.246625472437, 5521.585881058937, 5528.06022976095, 5546.63946843462, 5552.7223638817895, 6870.656467176621, 7047.506674532836, 7048.295170483013, 7151.034610327643, 7155.89266161008, 6761.0, 6765.830854228585, 6781.152355955505, 6783.118194634666, 6802.421794147355, 6930.61881596517, 6991.370776630128, 7083.220845707071, 7098.680559374738, 7103.396211321889, 6711.0940023096255, 6774.220964589135, 6799.966000169968, 6803.625800581016, 6821.0, 6811.761588344384, 6813.931860681329, 6818.147731533559, 6923.4807389447, 6931.549449285982, 6478.125453063964, 6553.5084868634085, 6592.17597800275, 6635.601863888182, 6645.401913827585, 6488.870222595616, 6589.374009469093, 6610.8347291318105, 6657.40083392497, 6666.100076489805, 6448.484121270193, 6453.838654033687, 6456.580322279036, 6544.345565443608, 6565.540412171103, 6597.1423714916755, 6601.867962640817, 6679.165104361955, 6719.832004199934, 6743.52795304324, 6399.488040956805, 6443.452306553995, 6517.185351831021, 6520.608763474207, 6524.6411447368955], "value": 6184.592471556421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.6847787513306, 949.1647350331702, 971.3297824501095, 1015.2030655935088, 1020.9897901020987, 44948.0, 46040.76979615106, 46057.539424605784, 46063.0, 46077.76961115194, 43274.0, 43377.7831110844, 43650.563494365044, 43758.781206093925, 43888.780556097256, 7667.309942105223, 7706.267904549059, 7765.611719414035, 7795.922040779605, 7797.76606701797, 7638.236176382373, 7744.767656970272, 7749.147593764681, 7753.612319384037, 7758.14660387357, 8417.158284171564, 8574.614142363609, 8611.827763444728, 8621.913780862205, 8627.0, 8495.235428811406, 8504.27713644341, 8557.27263182627, 8558.828823423528, 8571.485710857307, 8308.29379502743, 8346.207110324509, 8537.274331681814, 8537.701180458716, 8541.701040463555, 42164.0, 42338.0, 42376.0, 42564.1487170258, 42570.0, 3839.2705385976574, 3878.0886491674432, 3899.961000389988, 3904.609539046101, 3907.27715372657, 35067.1233219169, 35335.0, 35345.646543534494, 35394.46908296378, 35669.82165089184, 5396.568274538027, 5399.514043736082, 5413.593980451482, 5440.455954404568, 5471.452854714536, 240105.0, 240259.0, 240605.79697101578, 241343.0, 241899.0, 54931.725341373036, 54942.450575493735, 54969.72515137479, 55005.0, 55352.169717453464, 57731.42268577345, 57940.42059579435, 57969.0, 58041.41958580445, 58100.70949645225, 17349.21928513195, 17507.912460437616, 17615.647687046443, 17622.207000685, 17638.735418968725, 14112.082714623517, 14121.08212966154, 14129.646758831112, 14146.22195779242, 14245.287735613178, 15527.689446211012, 15694.195167555878, 15801.0, 15882.285297161656, 16013.839861601235, 5941.940580594139, 6110.7861224856915, 6200.410960958701, 6210.378962103753, 6224.533160013018, 1064.1965316186383, 1072.871255449351, 1087.608460954056, 1100.2518287564374, 1112.5772206561617, 26166.345841353737, 26242.86878565633, 26294.211173664822, 26610.334741631614, 26619.20142395731, 1202.3927916402336, 1206.90344772418, 1209.4255228766265, 1223.2904915149193, 1239.8388209532702, 13706.177629342272, 13828.585142445743, 13967.161970281815, 14122.858771412155, 14312.713745725026, 298499.0, 298692.0, 301637.0, 301713.0, 302030.0, 61308.69345653243, 62371.376286237464, 62965.68517157385, 67006.66496667486, 67155.66422167858, 1519.3011214841076, 1534.0948840184344, 1540.0374765771394, 1550.7983962084857, 1552.0687587447667, 30843.383132336778, 31962.84018579985, 32127.0, 32287.51568726424, 32350.0, 43256.0, 43447.34828977631, 43499.0, 43530.0, 43665.34501982536, 246723.0, 246995.0, 247734.0, 249339.0, 250101.0, 35975.10062248465, 37157.071073223386, 37165.25669486649, 37529.812350939166, 37547.62452375441, 47306.76346618245, 47544.0, 48162.0, 48203.75898120487, 48503.5149648499, 35544.644553554135, 35966.46050309195, 35986.10034749152, 36029.63970360263, 36096.63903361038, 35382.29235415226, 35523.28953420969, 35721.64278357287, 36424.08939776527, 36649.45025824561, 41361.58638413698, 41398.58601413947, 41481.0, 41734.373984389655, 41747.58252417558, 34464.310713786086, 35050.649493505756, 35366.64633353634, 35504.64495355013, 35547.82226088853, 25936.351591210372, 26655.600165997137, 26693.599596005686, 26828.329291767863, 26973.992210612483], "value": 19293.453792584987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.8607563298258, 634.66997161476, 636.7071147272253, 636.8980963045913, 639.9904001439979, 23137.537249255005, 23335.883320583373, 23652.05391784329, 23778.0, 24017.279481615536, 25110.372240693992, 26118.347041323977, 26201.868990655068, 26254.868725656346, 26260.868695656543, 6528.934710652892, 6629.33706629338, 6662.666866656672, 6666.100076489684, 6673.0, 6426.646534440604, 6515.185601799775, 6690.029945657877, 6707.8658426831435, 6710.563813352116, 6307.621542707429, 6636.104125942984, 6674.899876501856, 6683.164604424447, 6686.197656281253, 6584.934150658504, 6642.501812364092, 6650.168728908887, 6653.700583473756, 6654.667266636673, 6195.814125576195, 6203.534734894856, 6206.820704066213, 6212.534059945522, 6217.533684973645, 28987.275318117005, 29419.85290073536, 29969.250768730737, 30037.249068773235, 30100.397992040256, 2233.7207849018873, 2249.122842091569, 2249.696291000727, 2257.638777795561, 2260.2993072147688, 20461.693074603892, 20978.37064888056, 20995.475113122142, 21042.473938151517, 21052.684209736864, 2544.1349941019957, 2549.592065269548, 2592.4426248356503, 2612.7648511634043, 2628.6057091436246, 129177.0, 135000.0, 135234.0, 161846.19076904657, 168504.99999999878, 16324.918375408284, 16983.23575439108, 17020.148992550323, 17029.574260643334, 17161.399351022905, 26452.074177403698, 26510.46979060408, 26695.866520667274, 26725.19824405232, 26746.598801018, 10571.312864663772, 10647.25469217163, 10794.622188223531, 10942.726431839268, 10955.068819150461, 9651.179649729851, 9753.512324383752, 9811.067948544876, 9816.558254878548, 9857.211423086135, 9807.460589667495, 10060.647877324258, 10179.694609161737, 10242.334248273839, 10391.792164156826, 2892.696266891988, 2897.8116422432477, 2923.4299311634027, 2965.2142182321704, 3048.314129320885, 1031.4791030529534, 1047.0681093826502, 1056.2975621211808, 1057.0961827637414, 1058.7459009837582, 20731.689024664644, 20831.270905518235, 20938.0, 20953.26663566768, 21340.78659213419, 1108.7505311304892, 1111.3831823338126, 1115.9163062770162, 1125.352922069813, 1128.0580715102817, 11006.229563930448, 11317.71705707364, 11534.365609891369, 11546.826797598043, 11603.419829008515, 588854.0, 613258.0, 615614.0, 620479.0, 634693.0, 127317.36341318233, 129688.0, 131249.3437532806, 132862.0, 135863.0, 1070.1920050361928, 1211.8184769849327, 1228.600704770953, 1251.2617555642214, 1273.2869593027933, 21385.89307053517, 21489.785102148777, 21519.0, 21548.67676984878, 21740.347789566338, 61668.69165654143, 61889.0, 62235.0, 62335.37664623296, 62722.37277627165, 75337.0, 76021.6198919024, 78554.21445785469, 79161.60419197867, 80216.3956720874, 14706.485273015393, 14884.479043233436, 14968.775468368201, 14990.625234369229, 15004.174770387734, 23900.40248993789, 23901.0, 23938.760612393653, 24101.035958562163, 24142.63786043246, 19304.517387065436, 19694.606107878048, 19723.60552788965, 19760.20959161675, 19848.603027939072, 17358.82641173572, 17519.21163547618, 17903.910480447514, 17949.551261218574, 18100.18549165317, 19897.403077907686, 19920.70118948246, 20215.69676454825, 20353.898230508752, 20390.79609203889, 14620.561383158521, 14790.482333118289, 14852.480163194236, 14883.925580372028, 14913.0, 19097.33159339472, 19371.225150993803, 19468.415947521597, 19516.121774520463, 19561.315353962542], "value": 12796.518437862673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6504706346946, 1463.7950686903835, 1478.9186594737298, 1493.0146103571637, 1500.9249537523121, 16813.66372672546, 17561.47315580533, 17570.736438953427, 17576.38482653104, 17608.119594020296, 16913.83086169138, 16951.237194326255, 16963.74554381682, 17096.145192740343, 17096.316147354122, 2744.217897899099, 2750.064977907506, 2809.1712944681267, 2818.0841226601437, 2819.1824370932404, 2761.6685997680206, 2797.5384061629807, 2797.9860100699466, 2804.340979869729, 2812.170409729135, 2768.43247134338, 2792.2042217967883, 2866.8566571671436, 2867.455183515136, 2870.3541703116734, 2647.1529110684587, 2647.8940842366283, 2678.022521779556, 2680.32991752062, 2681.142034548945, 2647.8543680097587, 2750.573661082535, 2756.627855239537, 2776.1393967870026, 2776.583512473125, 16713.331466741314, 16827.74758378625, 16936.491905242863, 16939.068351240676, 16976.0, 7987.760367188994, 8187.1812818718245, 8191.221833925768, 8208.958955205246, 8227.876581851277, 5358.383785864637, 5432.13085906257, 5606.943930560683, 5645.096784514458, 5697.6296540724725, 2198.340497850654, 2200.570888676709, 2200.966985495219, 2254.9887250563806, 2259.7401298850514, 31047.37905241905, 31309.373812523623, 31318.530222046687, 31322.37355252905, 31410.842945785582, 7128.465365097639, 7293.416526677853, 7304.233055529199, 7419.443541734284, 7452.664630091659, 20474.488137796674, 20497.795022049886, 20532.897335513226, 20581.279655212296, 20624.69062964057, 8338.583070846433, 8548.358873084544, 8550.230479256898, 8552.700655477029, 8562.529060901586, 7672.769816905502, 7700.807479812937, 7784.727534536264, 7804.492707973964, 7816.218378162252, 5569.777208911679, 5653.604247702621, 5732.394929419769, 5808.506276966421, 5945.970270148621, 1612.6774645070798, 1640.7784949031966, 1652.6942515634646, 1675.103819456585, 1697.7623132761423, 971.1065819446127, 988.515627342597, 995.9601615935426, 1019.3883669798062, 1020.7958408318366, 8554.358423118167, 8660.783480412914, 8670.089640587774, 8830.293576513863, 8863.822723545622, 800.9439339246197, 814.8125931035895, 818.5702506184301, 824.6289169873581, 844.0630899701326, 5243.8164664236565, 5337.066013447631, 5749.626274292241, 5757.251557297524, 5862.413758624103, 24505.87747061289, 25725.099621513156, 25779.35551611187, 25961.740382595934, 26037.869810650827, 24864.0, 25337.366565835633, 25689.48621027569, 25960.22119336385, 25987.22038338853, 12249.510019599295, 12929.418176181905, 13014.869851301555, 13074.215547067206, 13087.803682944763, 9244.95377523108, 9507.857382139411, 9521.095495927875, 9533.761655958657, 9591.856122158033, 20654.896725516275, 20814.791852081285, 21544.24595139225, 21654.13383464707, 21722.56554868862, 21786.673199902332, 21891.781082189613, 21920.89039554792, 21964.560708785415, 22261.332160035225, 13003.47986080584, 13016.28410437435, 13123.278219697626, 13134.73730525365, 13136.40886160106, 15789.21053947321, 15897.364105436116, 15971.680566388375, 15996.600084997968, 16012.759808602646, 12214.450349734105, 12240.510379585074, 12427.627171184879, 12497.87502124967, 12687.302198379179, 11893.76212475763, 12085.456154473246, 12191.817122743343, 12329.568465103679, 12380.504779809067, 10611.89388106109, 10860.294080884718, 10870.836937445787, 10881.455927203766, 10882.0, 7519.1728909818785, 7522.734086139615, 7602.7339043133225, 7637.847243055219, 7666.501677390952, 7320.743773967885, 7414.406847452299, 7440.3675687567165, 7441.255874412515, 7498.0], "value": 7265.908094042803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3666365348024, 557.7239266563051, 575.1832397994848, 579.571117373144, 583.34665175004, 6156.753729850806, 6224.190855188819, 6263.248410190778, 6267.843303917404, 6309.0, 6192.907106393408, 6205.81382558524, 6212.223472065992, 6230.688465576714, 6235.469985051276, 5062.291279220912, 5078.4413714491375, 5084.822031228908, 5105.438401775802, 5116.462771409004, 4933.481984391641, 5043.319151914481, 5057.924131138036, 5059.822906198284, 5078.0, 4954.0, 5007.173816320321, 5012.8496145115705, 5037.168867136918, 5043.470435604264, 4943.431505376891, 4950.133726597867, 4975.800967961277, 5005.5995520358465, 5014.648974571745, 4465.508794032654, 4511.774411279423, 4546.909061818778, 4585.0, 4595.368644131318, 6001.909971350433, 6058.273007239115, 6113.969430152865, 6165.383461653843, 6174.765046990575, 5834.0, 5870.941290587125, 5932.466078052953, 5950.613210141327, 5960.731767070492, 6551.93448065518, 6624.933750662528, 6643.2063342897145, 6658.766943157015, 6701.93298067018, 4950.232713929311, 5120.334356533664, 5129.871753206163, 5159.484051594848, 5178.792848286064, 6743.4605231581845, 6797.728090876359, 6857.794266171973, 6881.4494840413145, 6944.4097251733665, 5254.714199323306, 5260.316158899395, 5287.920681189786, 5312.415634280226, 5338.839834804962, 5379.569634429236, 5394.811181608625, 5403.81145636018, 5420.214068960057, 5430.83707488776, 5881.852953676107, 5886.852828679317, 5890.558208134321, 5958.6722730249385, 5967.850803729942, 6655.334466553306, 6712.295209003082, 6735.046836417482, 6738.0, 6764.526483146133, 1858.7955324914249, 1867.1131212673872, 1867.1971052447307, 1886.8490520758307, 1892.8769629974283, 1275.859655437901, 1300.9072379201516, 1325.4300650720284, 1325.6354502511886, 1347.9797803032961, 6105.267367915879, 6133.6319820810895, 6196.132541444202, 6216.378362163748, 6217.875642487125, 6621.039949207338, 6652.368025037614, 6715.932840671629, 6759.594424334556, 6788.864222715617, 6106.4809491192855, 6146.416090471398, 6187.84530386735, 6192.659403732838, 6210.565260431817, 3555.768875023115, 3565.750397472204, 3568.107973006748, 3570.9285814283567, 3571.910702232465, 7037.331453511908, 7043.119610048744, 7045.1898031727005, 7060.54106483077, 7092.290770922867, 6889.931100689029, 6908.412784913338, 6918.619475928772, 6920.273371295942, 6957.304269573002, 6753.729850805913, 6970.546914450544, 6991.510594258353, 7047.859042819115, 7062.823429414203, 6601.669916504252, 6684.43182329488, 6691.397774200345, 6733.023711561698, 6769.3753499158865, 6625.879718490037, 6679.56582822115, 6698.430633396216, 6742.235683369795, 6787.694553745192, 7035.401990830836, 7047.6828542714675, 7053.259407762111, 7090.220075791762, 7143.6428178591905, 5186.196139598368, 5265.341832270966, 5279.445658205833, 5290.206469029523, 5296.364436267672, 6493.448056915215, 6592.538522303393, 6719.0, 6722.2605513394465, 6798.184217893884, 6453.870922581616, 6467.708953097216, 6543.967280163569, 6598.307177746459, 6611.603303801595, 6483.735671544004, 6519.185101862267, 6534.607923524603, 6593.142891424084, 6620.271770105188, 6260.655663938345, 6368.777092801915, 6408.551401402044, 6421.8394540135005, 6480.513961453004, 6511.674416279262, 6609.372109649576, 6638.701258443478, 6698.966505167443, 6712.731490740511, 6360.173177486897, 6424.743010279723, 6460.353964603502, 6470.320616335405, 6478.838029049311], "value": 5202.453960999897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [951.5765484359463, 983.9311248212625, 991.6380521109797, 999.2755252441981, 1012.9189664826814, 21004.26485073023, 21515.67726484102, 21569.1372345106, 21680.674789878165, 21826.89086554569, 19786.505337366572, 19880.602387952233, 20055.59888802227, 20067.498312542193, 20121.69817452736, 1048.1457612046177, 1067.2475904487317, 1069.5561342043043, 1069.5668254356997, 1075.7095584192264, 1053.5785685725693, 1079.1906070447164, 1079.2930630437038, 1083.2579682917226, 1084.4740300954031, 1132.2923173016864, 1138.5787258714288, 1140.8060629692973, 1143.262595625821, 1143.4454289669504, 1131.1064259235195, 1135.835303880941, 1138.4250953268588, 1138.5332013874272, 1140.5665846978095, 829.0383155539545, 834.7954751085962, 835.3943391041507, 836.1220718245818, 838.1743982177611, 20991.26530571438, 21722.891385543127, 21914.23300184502, 21936.45158871025, 22513.0, 23061.19285824988, 23175.188868389527, 23636.881815590812, 23647.527049459088, 24490.755092449024, 18419.355322563646, 18834.0, 18888.71666924997, 18949.052547372576, 18955.24179032837, 3929.9017524562114, 3986.960130398688, 3988.481497405348, 3989.4414781930554, 3990.102226998931, 159984.20007900003, 163670.18164909218, 163764.0, 165539.17230413892, 167385.0, 16587.585310367336, 16810.243539040526, 16844.157792110345, 16948.322067117177, 17335.479935601954, 33229.0, 35234.647653523134, 35493.290134197174, 35599.82200088983, 35621.0, 9269.768255793659, 9427.528623568795, 9542.188913942255, 9555.0, 9604.75988100289, 4663.626909847204, 4757.738324392191, 4757.809687612456, 4759.619230461555, 4767.547083027107, 6207.96896015517, 6222.471089957405, 6274.435300822856, 6320.146780184708, 6331.27190373113, 1162.598903378333, 1181.468339247342, 1200.9099317551218, 1206.6199147268583, 1209.7640960012889, 736.1681300130817, 744.765398899345, 748.3526749361763, 766.9961650191714, 768.7463137164722, 12618.747625047448, 12879.098463107492, 12921.612351629467, 13391.732165356638, 13406.731865362639, 737.8856277277031, 748.2143749063462, 760.3271105072051, 761.432732614206, 767.7044337929938, 6262.34245404226, 6290.276618188876, 6316.968415157895, 6337.873242535124, 6390.265119511223, 158755.0, 158895.20552397394, 158975.0, 161712.0, 164150.0, 135521.0, 138024.0, 139622.30188849193, 140319.29840350733, 141436.0, 123149.0, 124072.37963810124, 124204.37897810453, 124764.64994946876, 125796.37101814432, 11855.407229638311, 12004.519819207135, 12019.459124339252, 12063.517459301529, 12139.635810925687, 57956.4204357951, 58165.70917145387, 58172.70913645405, 58330.4166958325, 58564.707176463846, 72316.63841680757, 72965.6351718238, 73722.26277737154, 73960.0, 74441.0, 17270.222839972485, 17830.0, 17851.46445606634, 17978.0, 18082.367117150836, 18624.16191271369, 18745.343912963526, 18761.718574221126, 18842.623147537248, 18975.620487589895, 15616.687666246838, 15728.05631662104, 15820.446284379992, 15892.602684932506, 15906.363745450053, 16297.918510407371, 16335.836641633432, 16355.59111022234, 16499.422520211734, 16503.0, 16721.996680199227, 16741.91629041847, 16778.664426711643, 16886.74669879928, 16986.320547177973, 12256.816147757612, 12564.994800415761, 12571.497140114294, 12583.433745481292, 12692.0, 12035.157538972187, 12168.756624867276, 12510.374481276081, 12529.686757831127, 12649.87350126487], "value": 10002.774199677626, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1358.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 104.0, 104.0, 104.0, 106.0, 107.0, 106.0, 105.0, 105.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 113.0, 111.0, 112.0, 111.0, 111.0, 122.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 163.0, 164.0, 161.0, 163.0, 162.0, 163.0, 171.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 74.0, 74.0, 73.0, 74.0, 73.0, 81.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 77.0, 77.0, 77.0, 76.0, 79.0, 76.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 112.0, 115.0, 112.0, 111.0, 112.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 152.0, 150.0, 152.0, 151.0, 160.0, 151.0, 150.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 47.0, 43.0, 52.0, 44.0, 48.0, 44.0, 46.0, 43.0, 43.0], "value": 45.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 37.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 71.0, 70.0, 72.0, 70.0, 74.0, 71.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 103.0, 109.0, 105.0, 107.0, 105.0, 110.0, 107.0, 110.0], "value": 106.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 154.0, 150.0, 157.0, 146.0, 152.0, 145.0, 148.0, 144.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 59.0, 56.0, 60.0, 57.0, 65.0, 59.0, 58.0], "value": 58.6, "unit": "score"}]}]} 03:50:57 INFO - Return code: 0 03:50:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:57 INFO - # TBPL SUCCESS # 03:50:57 INFO - Running post-action listener: _package_coverage_data 03:50:57 INFO - Running post-action listener: _resource_record_post_action 03:50:57 INFO - [mozharness: 2017-10-02 10:50:57.558469Z] Finished run-tests step (success) 03:50:57 INFO - Running post-run listener: _resource_record_post_run 03:50:57 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 11526144; Write bytes: 454717440; Read time: 3788; Write time: 352512 03:50:57 INFO - TinderboxPrint: CPU usage
13.1% 03:50:57 INFO - TinderboxPrint: I/O read bytes / time
11,526,144 / 3,788 03:50:57 INFO - TinderboxPrint: I/O write bytes / time
454,717,440 / 352,512 03:50:57 INFO - TinderboxPrint: CPU idle
8,232.2 (86.9%) 03:50:57 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 03:50:57 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12390400; Read time: 0; Write time: 1460 03:50:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:50:57 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 11526144; Write bytes: 442327040; Read time: 3788; Write time: 351052 03:50:58 INFO - Running post-run listener: _upload_blobber_files 03:50:58 INFO - Blob upload gear active. 03:50:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:58 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 03:50:58 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'] 03:50:58 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 03:50:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:59 INFO - (blobuploader) - INFO - Done attempting. 03:50:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:06 INFO - (blobuploader) - INFO - Done attempting. 03:51:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:51:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:07 INFO - (blobuploader) - INFO - Done attempting. 03:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:08 INFO - (blobuploader) - INFO - Done attempting. 03:51:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:08 INFO - Return code: 0 03:51:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b361c2da1f089dc6a101f9a21b601eb2204153ca535a2736fd4406af38ab78619670e9935dc78f06079103792df7e821413da116ef8d3b9a39efab14a751b5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e4319c9a2b9160fdf5383f36bdaecec30207dcf10e54689f963158e50702f6bb2162eabaec421429c40ab5a36e63906881be5c9b7b3777a5f477e1f00f3739", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e454f634edee05b2bca12c8cbe92c7086ddeba3604fd237e469b1dd63296cce50d0ac443e47ce8215dbb9b67015aed70e422f008852af3c778d009431de8fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bec69bb2ea7a2f7cc189efb1c131be17c8287e95730a49718d4419c01df65dead644b1219cc3c748691f3398c3b679b03870e4fb0313781665a5bc7ea2488e"} 03:51:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:08 INFO - Contents: 03:51:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b361c2da1f089dc6a101f9a21b601eb2204153ca535a2736fd4406af38ab78619670e9935dc78f06079103792df7e821413da116ef8d3b9a39efab14a751b5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e4319c9a2b9160fdf5383f36bdaecec30207dcf10e54689f963158e50702f6bb2162eabaec421429c40ab5a36e63906881be5c9b7b3777a5f477e1f00f3739", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e454f634edee05b2bca12c8cbe92c7086ddeba3604fd237e469b1dd63296cce50d0ac443e47ce8215dbb9b67015aed70e422f008852af3c778d009431de8fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bec69bb2ea7a2f7cc189efb1c131be17c8287e95730a49718d4419c01df65dead644b1219cc3c748691f3398c3b679b03870e4fb0313781665a5bc7ea2488e"} 03:51:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:08 INFO - Copying logs to upload dir... 03:51:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.084939 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-10-02 03:51:08.956613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 03:51:08.961191) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211 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/e1b361c2da1f089dc6a101f9a21b601eb2204153ca535a2736fd4406af38ab78619670e9935dc78f06079103792df7e821413da116ef8d3b9a39efab14a751b5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e4319c9a2b9160fdf5383f36bdaecec30207dcf10e54689f963158e50702f6bb2162eabaec421429c40ab5a36e63906881be5c9b7b3777a5f477e1f00f3739", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e454f634edee05b2bca12c8cbe92c7086ddeba3604fd237e469b1dd63296cce50d0ac443e47ce8215dbb9b67015aed70e422f008852af3c778d009431de8fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bec69bb2ea7a2f7cc189efb1c131be17c8287e95730a49718d4419c01df65dead644b1219cc3c748691f3398c3b679b03870e4fb0313781665a5bc7ea2488e"} build_url:https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/feUfNV96Qne6kN5PXEa8NA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1b361c2da1f089dc6a101f9a21b601eb2204153ca535a2736fd4406af38ab78619670e9935dc78f06079103792df7e821413da116ef8d3b9a39efab14a751b5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e4319c9a2b9160fdf5383f36bdaecec30207dcf10e54689f963158e50702f6bb2162eabaec421429c40ab5a36e63906881be5c9b7b3777a5f477e1f00f3739", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e454f634edee05b2bca12c8cbe92c7086ddeba3604fd237e469b1dd63296cce50d0ac443e47ce8215dbb9b67015aed70e422f008852af3c778d009431de8fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50bec69bb2ea7a2f7cc189efb1c131be17c8287e95730a49718d4419c01df65dead644b1219cc3c748691f3398c3b679b03870e4fb0313781665a5bc7ea2488e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 03:51:08.989577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:51:08.992935) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506938888.120927-173748211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:51:09.075682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 03:51:09.076001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 03:51:09.076290) ========= ========= Total master_lag: 0.28 =========