builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1504036255.75 results: success (0) revision: 9957a25209908aaea4bfd4915c3201f006b29b6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.751349) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.751862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.752140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.768295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.768641) ========= 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=d2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-29 12:50:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-08-29 12:50:55 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.910835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.911152) ========= 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=d2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014038 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:55.960962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-29 12:50:55.961300) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9957a25209908aaea4bfd4915c3201f006b29b6e --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 9957a25209908aaea4bfd4915c3201f006b29b6e --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=d2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-29 12:50:56,012 truncating revision to first 12 chars 2017-08-29 12:50:56,012 Setting DEBUG logging. 2017-08-29 12:50:56,012 attempt 1/10 2017-08-29 12:50:56,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9957a2520990?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-29 12:50:57,442 unpacking tar archive at: mozilla-central-9957a2520990/testing/mozharness/ program finished with exit code 0 elapsedTime=1.784619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-29 12:50:57.761082) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:57.761414) ========= script_repo_revision: 9957a25209908aaea4bfd4915c3201f006b29b6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:57.761907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:57.762183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:57.773323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-29 12:50:57.773761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=d2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:57 INFO - MultiFileLogger online at 20170829 12:50:57 in /builds/slave/test 12:50:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:50:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:57 INFO - {'append_to_log': False, 12:50:57 INFO - 'base_work_dir': '/builds/slave/test', 12:50:57 INFO - 'blob_upload_branch': 'Firefox', 12:50:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:57 INFO - 'branch': 'Firefox', 12:50:57 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:57 INFO - 'code_coverage': False, 12:50:57 INFO - 'config_files': ('talos/linux_config.py',), 12:50:57 INFO - 'default_actions': ('clobber', 12:50:57 INFO - 'read-buildbot-config', 12:50:57 INFO - 'download-and-extract', 12:50:57 INFO - 'populate-webroot', 12:50:57 INFO - 'create-virtualenv', 12:50:57 INFO - 'install', 12:50:57 INFO - 'setup-mitmproxy', 12:50:57 INFO - 'run-tests'), 12:50:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:57 INFO - 'disable_ccov_upload': False, 12:50:57 INFO - 'disable_stylo': False, 12:50:57 INFO - 'download_minidump_stackwalk': True, 12:50:57 INFO - 'download_symbols': 'ondemand', 12:50:57 INFO - 'enable_stylo': False, 12:50:57 INFO - 'enable_webrender': False, 12:50:57 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:50:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:57 INFO - 'gecko_profile': False, 12:50:57 INFO - 'gecko_profile_interval': 0, 12:50:57 INFO - 'installer_path': 'installer.exe', 12:50:57 INFO - 'log_level': 'info', 12:50:57 INFO - 'log_name': 'talos', 12:50:57 INFO - 'log_to_console': True, 12:50:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:57 INFO - 'opt_config_files': (), 12:50:57 INFO - 'pip_index': False, 12:50:57 INFO - 'suite': 'dromaeojs-e10s', 12:50:57 INFO - 'system_bits': '32', 12:50:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:57 INFO - 'title': 'talos-linux64-ix-043', 12:50:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:57 INFO - 'use_talos_json': True, 12:50:57 INFO - 'verify': 'False', 12:50:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:57 INFO - 'work_dir': 'build'} 12:50:57 INFO - [mozharness: 2017-08-29 19:50:57.975198Z] Running clobber step. 12:50:57 INFO - Running pre-action listener: _resource_record_pre_action 12:50:57 INFO - Running main action method: clobber 12:50:57 INFO - rmtree: /builds/slave/test/build 12:50:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:59 INFO - Running post-action listener: _resource_record_post_action 12:50:59 INFO - [mozharness: 2017-08-29 19:50:59.000628Z] Finished clobber step (success) 12:50:59 INFO - [mozharness: 2017-08-29 19:50:59.000724Z] Running read-buildbot-config step. 12:50:59 INFO - Running pre-action listener: _resource_record_pre_action 12:50:59 INFO - Running main action method: read_buildbot_config 12:50:59 INFO - Using buildbot properties: 12:50:59 INFO - { 12:50:59 INFO - "project": "", 12:50:59 INFO - "product": "firefox", 12:50:59 INFO - "who": "ffxbld@noreply.mozilla.org", 12:50:59 INFO - "installer_path": "public/build/target.tar.bz2", 12:50:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 12:50:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:50:59 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 12:50:59 INFO - "stage_platform": "linux64-qr", 12:50:59 INFO - "basedir": "/builds/slave/test", 12:50:59 INFO - "buildnumber": 21, 12:50:59 INFO - "platform": "ubuntu64_hw_qr", 12:50:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:50:59 INFO - "slavebuilddir": "test", 12:50:59 INFO - "taskId": "KNpN8l7aQS6LrLr_VA3BjQ", 12:50:59 INFO - "branch": "mozilla-central", 12:50:59 INFO - "script_repo_revision": "production", 12:50:59 INFO - "revision": "9957a25209908aaea4bfd4915c3201f006b29b6e", 12:50:59 INFO - "slavename": "talos-linux64-ix-043", 12:50:59 INFO - "repo_path": "mozilla-central" 12:50:59 INFO - } 12:50:59 INFO - Finding installer, test and symbols from parent task. 12:50:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNpN8l7aQS6LrLr_VA3BjQ'}, attempt #1 12:50:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNpN8l7aQS6LrLr_VA3BjQ'}, attempt #1 12:50:59 INFO - Task dependencies: I8xynoCOTwiPbft2MqBxhQ 12:50:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ'}, attempt #1 12:51:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.test_packages.json 12:51:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.crashreporter-symbols.zip 12:51:00 INFO - Running post-action listener: _resource_record_post_action 12:51:00 INFO - [mozharness: 2017-08-29 19:51:00.591876Z] Finished read-buildbot-config step (success) 12:51:00 INFO - [mozharness: 2017-08-29 19:51:00.592092Z] Running download-and-extract step. 12:51:00 INFO - Running pre-action listener: _resource_record_pre_action 12:51:00 INFO - Running main action method: download_and_extract 12:51:00 INFO - mkdir: /builds/slave/test/build/tests 12:51: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')]} 12:51:00 INFO - trying https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.test_packages.json 12:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:51:01 INFO - Downloaded 989 bytes. 12:51:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:51:01 INFO - Using the following test package requirements: 12:51:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:51:01 INFO - u'common': [u'target.common.tests.zip'], 12:51:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:51:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:51:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:51:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:51:01 INFO - u'mozbase': [u'target.common.tests.zip'], 12:51:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:51:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:51:01 INFO - u'web-platform': [u'target.common.tests.zip', 12:51:01 INFO - u'target.web-platform.tests.tar.gz'], 12:51:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:51:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip 12:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip into memory 12:51:02 INFO - Content-Length response header: 54980756 12:51:02 INFO - Bytes received: 54980756 12:51:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:51:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip 12:51:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:51:13 INFO - Fetch https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip into memory 12:51:14 INFO - Content-Length response header: 54980756 12:51:14 INFO - Bytes received: 54980756 12:51:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.talos.tests.zip 12:51:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:51:27 INFO - Fetch https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.talos.tests.zip into memory 12:51:28 INFO - Content-Length response header: 14496610 12:51:28 INFO - Bytes received: 14496610 12:51:28 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')]} 12:51:28 INFO - trying https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:28 INFO - Downloading https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:51:30 INFO - Downloaded 62681709 bytes. 12:51:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:30 INFO - mkdir: /builds/slave/test/properties 12:51:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:51:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:51:30 INFO - Contents: 12:51:30 INFO - build_url:https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:30 INFO - Running post-action listener: _resource_record_post_action 12:51:30 INFO - Running post-action listener: find_tests_for_verification 12:51:30 INFO - Running post-action listener: set_extra_try_arguments 12:51:30 INFO - [mozharness: 2017-08-29 19:51:30.557397Z] Finished download-and-extract step (success) 12:51:30 INFO - [mozharness: 2017-08-29 19:51:30.557493Z] Running populate-webroot step. 12:51:30 INFO - Running pre-action listener: _resource_record_pre_action 12:51:30 INFO - Running main action method: populate_webroot 12:51:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:51:30 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:51:30 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:51:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:30 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'tests': ['damp', 'tps']}, 12:51:30 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['damp', 'tps']}, 12:51:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:51:30 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:51:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:51:30 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:51:30 INFO - 'other-e10s': {'tests': ['a11yr', 12:51:30 INFO - 'ts_paint', 12:51:30 INFO - 'tpaint', 12:51:30 INFO - 'sessionrestore', 12:51:30 INFO - 'sessionrestore_many_windows', 12:51:30 INFO - 'sessionrestore_no_auto_restore', 12:51:30 INFO - 'tabpaint']}, 12:51:30 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['a11yr', 12:51:30 INFO - 'ts_paint', 12:51:30 INFO - 'tpaint', 12:51:30 INFO - 'sessionrestore', 12:51:30 INFO - 'sessionrestore_many_windows', 12:51:30 INFO - 'sessionrestore_no_auto_restore', 12:51:30 INFO - 'tabpaint']}, 12:51:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:51:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 12:51:30 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['bloom_basic_singleton']}, 12:51:30 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['bloom_basic']}, 12:51:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:51:30 INFO - 'tsvgr_opacity', 12:51:30 INFO - 'tart', 12:51:30 INFO - 'tscrollx', 12:51:30 INFO - 'tsvg_static']}, 12:51:30 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['tsvgx', 12:51:30 INFO - 'tsvgr_opacity', 12:51:30 INFO - 'tart', 12:51:30 INFO - 'tscrollx', 12:51:30 INFO - 'tsvg_static']}, 12:51:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:51:30 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo'], 12:51:30 INFO - 'tests': ['tp5o']}, 12:51:30 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:51:30 INFO - 'talos_options': ['--mitmproxy', 12:51:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:51:30 INFO - '--firstNonBlankPaint'], 12:51:30 INFO - 'tests': ['tp6_google', 12:51:30 INFO - 'tp6_youtube', 12:51:30 INFO - 'tp6_amazon', 12:51:30 INFO - 'tp6_facebook']}, 12:51:30 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo', 12:51:30 INFO - '--mitmproxy', 12:51:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:51:30 INFO - '--firstNonBlankPaint'], 12:51:30 INFO - 'tests': ['tp6_google', 12:51:30 INFO - 'tp6_youtube', 12:51:30 INFO - 'tp6_amazon', 12:51:30 INFO - 'tp6_facebook']}, 12:51:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo', 12:51:30 INFO - '--stylo-threads=1', 12:51:30 INFO - '--mitmproxy', 12:51:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:51:30 INFO - '--firstNonBlankPaint'], 12:51:30 INFO - 'tests': ['tp6_google', 12:51:30 INFO - 'tp6_youtube', 12:51:30 INFO - 'tp6_amazon', 12:51:30 INFO - 'tp6_facebook']}, 12:51:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'talos_options': ['--xperf_path', 12:51:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:30 INFO - 'tests': ['tp5n']}, 12:51:30 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:30 INFO - 'talos_options': ['--enable-stylo', 12:51:30 INFO - '--xperf_path', 12:51:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:30 INFO - 'tests': ['tp5n']}}} 12:51:30 INFO - Running post-action listener: _resource_record_post_action 12:51:30 INFO - [mozharness: 2017-08-29 19:51:30.571674Z] Finished populate-webroot step (success) 12:51:30 INFO - [mozharness: 2017-08-29 19:51:30.571763Z] Running create-virtualenv step. 12:51:30 INFO - Running pre-action listener: _resource_record_pre_action 12:51:30 INFO - Running main action method: create_virtualenv 12:51:30 INFO - Creating virtualenv /builds/slave/test/build/venv 12:51:30 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:51:30 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:51:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:51:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:51:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:31 INFO - Installing pip...............done. 12:51:31 INFO - Return code: 0 12:51:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:51:31 INFO - Reading from file tmpfile_stdout 12:51:31 INFO - Output received: 12:51:31 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:51:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:51:31 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')]} 12:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:31 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')]} 12:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:31 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:31 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 12:51:31 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 12:51:31 INFO - Using env: {'DISPLAY': ':0', 12:51:31 INFO - 'HOME': '/home/cltbld', 12:51:31 INFO - 'LANG': 'en_US.UTF-8', 12:51:31 INFO - 'LANGUAGE': 'en_US:en', 12:51:31 INFO - 'LOGNAME': 'cltbld', 12:51:31 INFO - 'MAIL': '/var/mail/cltbld', 12:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:31 INFO - 'MOZ_NO_REMOTE': '1', 12:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:31 INFO - 'NO_EM_RESTART': '1', 12:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:31 INFO - 'PWD': '/builds/slave/test', 12:51:31 INFO - 'SHELL': '/bin/bash', 12:51:31 INFO - 'SHLVL': '1', 12:51:31 INFO - 'TERM': 'linux', 12:51:31 INFO - 'TMOUT': '86400', 12:51:31 INFO - 'USER': 'cltbld', 12:51:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:31 INFO - '_': '/tools/buildbot/bin/python'} 12:51:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:51:32 INFO - Downloading/unpacking pip>=1.5 12:51:32 INFO - Running setup.py egg_info for package pip 12:51:32 INFO - warning: no files found matching 'pip/cacert.pem' 12:51:32 INFO - warning: no files found matching '*.html' under directory 'docs' 12:51:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:51:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:51:32 INFO - Installing collected packages: pip 12:51:32 INFO - Found existing installation: pip 1.1 12:51:32 INFO - Uninstalling pip: 12:51:32 INFO - Successfully uninstalled pip 12:51:32 INFO - Running setup.py install for pip 12:51:32 INFO - warning: no files found matching 'pip/cacert.pem' 12:51:32 INFO - warning: no files found matching '*.html' under directory 'docs' 12:51:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:51:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:51:32 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Successfully installed pip 12:51:32 INFO - Cleaning up... 12:51:32 INFO - Return code: 0 12:51:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:51:32 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')]} 12:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:32 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')]} 12:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:32 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:32 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 12:51:32 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 12:51:32 INFO - Using env: {'DISPLAY': ':0', 12:51:32 INFO - 'HOME': '/home/cltbld', 12:51:32 INFO - 'LANG': 'en_US.UTF-8', 12:51:32 INFO - 'LANGUAGE': 'en_US:en', 12:51:32 INFO - 'LOGNAME': 'cltbld', 12:51:32 INFO - 'MAIL': '/var/mail/cltbld', 12:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:32 INFO - 'MOZ_NO_REMOTE': '1', 12:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:32 INFO - 'NO_EM_RESTART': '1', 12:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:32 INFO - 'PWD': '/builds/slave/test', 12:51:32 INFO - 'SHELL': '/bin/bash', 12:51:32 INFO - 'SHLVL': '1', 12:51:32 INFO - 'TERM': 'linux', 12:51:32 INFO - 'TMOUT': '86400', 12:51:32 INFO - 'USER': 'cltbld', 12:51:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:32 INFO - '_': '/tools/buildbot/bin/python'} 12:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:32 INFO - Downloading/unpacking psutil>=3.1.1 12:51:32 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 12:51:32 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 12:51:32 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 12:51:32 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 12:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:34 INFO - Installing collected packages: psutil 12:51:34 INFO - Running setup.py install for psutil 12:51:34 INFO - building 'psutil._psutil_linux' extension 12:51:34 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 12:51:34 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 12:51:34 INFO - building 'psutil._psutil_posix' extension 12:51:34 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 12:51:34 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 12:51:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:34 INFO - Successfully installed psutil 12:51:34 INFO - Cleaning up... 12:51:34 INFO - Return code: 0 12:51:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:51:34 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')]} 12:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:34 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')]} 12:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:34 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:34 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 12:51:34 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 12:51:34 INFO - Using env: {'DISPLAY': ':0', 12:51:34 INFO - 'HOME': '/home/cltbld', 12:51:34 INFO - 'LANG': 'en_US.UTF-8', 12:51:34 INFO - 'LANGUAGE': 'en_US:en', 12:51:34 INFO - 'LOGNAME': 'cltbld', 12:51:34 INFO - 'MAIL': '/var/mail/cltbld', 12:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:34 INFO - 'MOZ_NO_REMOTE': '1', 12:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:34 INFO - 'NO_EM_RESTART': '1', 12:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:34 INFO - 'PWD': '/builds/slave/test', 12:51:34 INFO - 'SHELL': '/bin/bash', 12:51:34 INFO - 'SHLVL': '1', 12:51:34 INFO - 'TERM': 'linux', 12:51:34 INFO - 'TMOUT': '86400', 12:51:34 INFO - 'USER': 'cltbld', 12:51:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:34 INFO - '_': '/tools/buildbot/bin/python'} 12:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:51:34 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 12:51:34 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 12:51:34 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 12:51:34 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 12:51:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:51:36 INFO - Installing collected packages: mozsystemmonitor 12:51:36 INFO - Running setup.py install for mozsystemmonitor 12:51:36 INFO - Successfully installed mozsystemmonitor 12:51:36 INFO - Cleaning up... 12:51:36 INFO - Return code: 0 12:51:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:36 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:36 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 12:51:36 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 12:51:36 INFO - Using env: {'DISPLAY': ':0', 12:51:36 INFO - 'HOME': '/home/cltbld', 12:51:36 INFO - 'LANG': 'en_US.UTF-8', 12:51:36 INFO - 'LANGUAGE': 'en_US:en', 12:51:36 INFO - 'LOGNAME': 'cltbld', 12:51:36 INFO - 'MAIL': '/var/mail/cltbld', 12:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:36 INFO - 'MOZ_NO_REMOTE': '1', 12:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:36 INFO - 'NO_EM_RESTART': '1', 12:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:36 INFO - 'PWD': '/builds/slave/test', 12:51:36 INFO - 'SHELL': '/bin/bash', 12:51:36 INFO - 'SHLVL': '1', 12:51:36 INFO - 'TERM': 'linux', 12:51:36 INFO - 'TMOUT': '86400', 12:51:36 INFO - 'USER': 'cltbld', 12:51:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:36 INFO - '_': '/tools/buildbot/bin/python'} 12:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:36 INFO - Downloading/unpacking jsonschema==2.5.1 12:51:36 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 12:51:36 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 12:51:36 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 12:51:36 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 12:51:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:51:37 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 12:51:37 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 12:51:37 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 12:51:37 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 12:51:37 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:37 INFO - warning: no files found matching '*.txt' 12:51:37 INFO - no previously-included directories found matching 'build' 12:51:37 INFO - no previously-included directories found matching 'dist' 12:51:37 INFO - no previously-included directories found matching '.git*' 12:51:37 INFO - Installing collected packages: jsonschema, functools32 12:51:37 INFO - Running setup.py install for functools32 12:51:37 INFO - warning: no files found matching '*.txt' 12:51:37 INFO - no previously-included directories found matching 'build' 12:51:37 INFO - no previously-included directories found matching 'dist' 12:51:37 INFO - no previously-included directories found matching '.git*' 12:51:37 INFO - Successfully installed jsonschema functools32 12:51:37 INFO - Cleaning up... 12:51:37 INFO - Return code: 0 12:51:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:37 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:37 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 12:51:37 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 12:51:37 INFO - Using env: {'DISPLAY': ':0', 12:51:37 INFO - 'HOME': '/home/cltbld', 12:51:37 INFO - 'LANG': 'en_US.UTF-8', 12:51:37 INFO - 'LANGUAGE': 'en_US:en', 12:51:37 INFO - 'LOGNAME': 'cltbld', 12:51:37 INFO - 'MAIL': '/var/mail/cltbld', 12:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:37 INFO - 'MOZ_NO_REMOTE': '1', 12:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:37 INFO - 'NO_EM_RESTART': '1', 12:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:37 INFO - 'PWD': '/builds/slave/test', 12:51:37 INFO - 'SHELL': '/bin/bash', 12:51:37 INFO - 'SHLVL': '1', 12:51:37 INFO - 'TERM': 'linux', 12:51:37 INFO - 'TMOUT': '86400', 12:51:37 INFO - 'USER': 'cltbld', 12:51:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:37 INFO - '_': '/tools/buildbot/bin/python'} 12:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:51:38 INFO - Cleaning up... 12:51:38 INFO - Return code: 0 12:51:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:51:38 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')]} 12:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:38 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')]} 12:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:38 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:38 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 12:51:38 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 12:51:38 INFO - Using env: {'DISPLAY': ':0', 12:51:38 INFO - 'HOME': '/home/cltbld', 12:51:38 INFO - 'LANG': 'en_US.UTF-8', 12:51:38 INFO - 'LANGUAGE': 'en_US:en', 12:51:38 INFO - 'LOGNAME': 'cltbld', 12:51:38 INFO - 'MAIL': '/var/mail/cltbld', 12:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:38 INFO - 'MOZ_NO_REMOTE': '1', 12:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:38 INFO - 'NO_EM_RESTART': '1', 12:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:38 INFO - 'PWD': '/builds/slave/test', 12:51:38 INFO - 'SHELL': '/bin/bash', 12:51:38 INFO - 'SHLVL': '1', 12:51:38 INFO - 'TERM': 'linux', 12:51:38 INFO - 'TMOUT': '86400', 12:51:38 INFO - 'USER': 'cltbld', 12:51:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:38 INFO - '_': '/tools/buildbot/bin/python'} 12:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 12:51:38 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 12:51:38 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 12:51:38 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 12:51:38 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 12:51:39 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 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 12:51:39 INFO - Downloading docopt-0.6.1.tar.gz 12:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:40 INFO - Running setup.py install for blobuploader 12:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:51:40 INFO - Running setup.py install for requests 12:51:40 INFO - Running setup.py install for docopt 12:51:40 INFO - Successfully installed blobuploader requests docopt 12:51:40 INFO - Cleaning up... 12:51:40 INFO - Return code: 0 12:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:40 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')]} 12:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:40 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')]} 12:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:40 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:40 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 12:51:40 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 12:51:40 INFO - Using env: {'DISPLAY': ':0', 12:51:40 INFO - 'HOME': '/home/cltbld', 12:51:40 INFO - 'LANG': 'en_US.UTF-8', 12:51:40 INFO - 'LANGUAGE': 'en_US:en', 12:51:40 INFO - 'LOGNAME': 'cltbld', 12:51:40 INFO - 'MAIL': '/var/mail/cltbld', 12:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:40 INFO - 'MOZ_NO_REMOTE': '1', 12:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:40 INFO - 'NO_EM_RESTART': '1', 12:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:40 INFO - 'PWD': '/builds/slave/test', 12:51:40 INFO - 'SHELL': '/bin/bash', 12:51:40 INFO - 'SHLVL': '1', 12:51:40 INFO - 'TERM': 'linux', 12:51:40 INFO - 'TMOUT': '86400', 12:51:40 INFO - 'USER': 'cltbld', 12:51:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:40 INFO - '_': '/tools/buildbot/bin/python'} 12:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:40 INFO - Running setup.py (path:/tmp/pip-qh8FqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:40 INFO - Running setup.py (path:/tmp/pip-eH7JcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:40 INFO - Running setup.py (path:/tmp/pip-q5NdgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:41 INFO - Running setup.py (path:/tmp/pip-fZKZ9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:41 INFO - Running setup.py (path:/tmp/pip-BI6htN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:41 INFO - Running setup.py (path:/tmp/pip-7LfSEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:41 INFO - Running setup.py (path:/tmp/pip-koF2cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:41 INFO - Running setup.py (path:/tmp/pip-gq5a3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:41 INFO - Running setup.py (path:/tmp/pip-IhiBGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:41 INFO - Running setup.py (path:/tmp/pip-wkXrQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:41 INFO - Running setup.py (path:/tmp/pip-FkdrsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:41 INFO - Running setup.py (path:/tmp/pip-i9gDr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:41 INFO - Running setup.py (path:/tmp/pip-hOnnjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:41 INFO - Running setup.py (path:/tmp/pip-NLY9mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:41 INFO - Running setup.py (path:/tmp/pip-WXPZhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:41 INFO - Running setup.py (path:/tmp/pip-HqfTZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:41 INFO - Running setup.py (path:/tmp/pip-YMedQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:41 INFO - Running setup.py install for manifestparser 12:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Running setup.py install for mozcrash 12:51:42 INFO - Running setup.py install for mozdebug 12:51:42 INFO - Running setup.py install for mozdevice 12:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Running setup.py install for mozfile 12:51:42 INFO - Running setup.py install for mozhttpd 12:51:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Running setup.py install for mozinfo 12:51:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Running setup.py install for mozInstall 12:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Running setup.py install for mozleak 12:51:42 INFO - Running setup.py install for mozlog 12:51:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Running setup.py install for moznetwork 12:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Running setup.py install for mozprocess 12:51:43 INFO - Running setup.py install for mozprofile 12:51:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Running setup.py install for mozrunner 12:51:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Running setup.py install for mozscreenshot 12:51:43 INFO - Running setup.py install for moztest 12:51:43 INFO - Running setup.py install for mozversion 12:51:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:43 INFO - Cleaning up... 12:51:43 INFO - Return code: 0 12:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:43 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:43 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 12:51:43 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 12:51:43 INFO - Using env: {'DISPLAY': ':0', 12:51:43 INFO - 'HOME': '/home/cltbld', 12:51:43 INFO - 'LANG': 'en_US.UTF-8', 12:51:43 INFO - 'LANGUAGE': 'en_US:en', 12:51:43 INFO - 'LOGNAME': 'cltbld', 12:51:43 INFO - 'MAIL': '/var/mail/cltbld', 12:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:43 INFO - 'MOZ_NO_REMOTE': '1', 12:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:43 INFO - 'NO_EM_RESTART': '1', 12:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:43 INFO - 'PWD': '/builds/slave/test', 12:51:43 INFO - 'SHELL': '/bin/bash', 12:51:43 INFO - 'SHLVL': '1', 12:51:43 INFO - 'TERM': 'linux', 12:51:43 INFO - 'TMOUT': '86400', 12:51:43 INFO - 'USER': 'cltbld', 12:51:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:43 INFO - '_': '/tools/buildbot/bin/python'} 12:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:43 INFO - Running setup.py (path:/tmp/pip-_rFA0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:44 INFO - Running setup.py (path:/tmp/pip-UV2CIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:44 INFO - Running setup.py (path:/tmp/pip-gQgzPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:44 INFO - Running setup.py (path:/tmp/pip-RZ8yvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:44 INFO - Running setup.py (path:/tmp/pip-gMwdYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:44 INFO - Running setup.py (path:/tmp/pip-cT3pWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:44 INFO - Running setup.py (path:/tmp/pip-TRckwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:44 INFO - Running setup.py (path:/tmp/pip-yK70Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:44 INFO - Running setup.py (path:/tmp/pip-Vts3m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:44 INFO - Running setup.py (path:/tmp/pip-ArnL43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:44 INFO - Running setup.py (path:/tmp/pip-OJ69e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:44 INFO - Running setup.py (path:/tmp/pip-qepoKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:44 INFO - Running setup.py (path:/tmp/pip-ow2Gfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:44 INFO - Running setup.py (path:/tmp/pip-1VJzw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:44 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)) 12:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:44 INFO - Running setup.py (path:/tmp/pip-hZygsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:45 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)) 12:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:45 INFO - Running setup.py (path:/tmp/pip-PqyssD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:45 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)) 12:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:45 INFO - Running setup.py (path:/tmp/pip-cTB0CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:45 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)) 12:51:45 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)) 12:51:45 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)) 12:51:45 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)) 12:51:45 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)) 12:51:45 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)) 12:51:45 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)) 12:51:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:46 INFO - Downloading blessings-1.6.tar.gz 12:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:46 INFO - Installing collected packages: blessings 12:51:46 INFO - Running setup.py install for blessings 12:51:46 INFO - Successfully installed blessings 12:51:46 INFO - Cleaning up... 12:51:46 INFO - Return code: 0 12:51:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:46 INFO - Reading from file tmpfile_stdout 12:51:46 INFO - Current package versions: 12:51:46 INFO - argparse == 1.2.1 12:51:46 INFO - blessings == 1.6 12:51:46 INFO - blobuploader == 1.2.4 12:51:46 INFO - docopt == 0.6.1 12:51:46 INFO - functools32 == 3.2.3-2 12:51:46 INFO - jsonschema == 2.5.1 12:51:46 INFO - manifestparser == 1.1 12:51:46 INFO - mozInstall == 1.13 12:51:46 INFO - mozcrash == 1.0 12:51:46 INFO - mozdebug == 0.1 12:51:46 INFO - mozdevice == 0.51 12:51:46 INFO - mozfile == 1.2 12:51:46 INFO - mozhttpd == 0.7 12:51:46 INFO - mozinfo == 0.10 12:51:46 INFO - mozleak == 0.1 12:51:46 INFO - mozlog == 3.5 12:51:46 INFO - moznetwork == 0.27 12:51:46 INFO - mozprocess == 0.25 12:51:46 INFO - mozprofile == 0.28 12:51:46 INFO - mozrunner == 6.13 12:51:46 INFO - mozscreenshot == 0.1 12:51:46 INFO - mozsystemmonitor == 0.3 12:51:46 INFO - moztest == 0.8 12:51:46 INFO - mozversion == 1.4 12:51:46 INFO - psutil == 3.1.1 12:51:46 INFO - requests == 1.2.3 12:51:46 INFO - wsgiref == 0.1.2 12:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:46 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 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:46 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 12:51:46 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 12:51:46 INFO - Using env: {'DISPLAY': ':0', 12:51:46 INFO - 'HOME': '/home/cltbld', 12:51:46 INFO - 'LANG': 'en_US.UTF-8', 12:51:46 INFO - 'LANGUAGE': 'en_US:en', 12:51:46 INFO - 'LOGNAME': 'cltbld', 12:51:46 INFO - 'MAIL': '/var/mail/cltbld', 12:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:46 INFO - 'MOZ_NO_REMOTE': '1', 12:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:46 INFO - 'NO_EM_RESTART': '1', 12:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:46 INFO - 'PWD': '/builds/slave/test', 12:51:46 INFO - 'SHELL': '/bin/bash', 12:51:46 INFO - 'SHLVL': '1', 12:51:46 INFO - 'TERM': 'linux', 12:51:46 INFO - 'TMOUT': '86400', 12:51:46 INFO - 'USER': 'cltbld', 12:51:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:46 INFO - '_': '/tools/buildbot/bin/python'} 12:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 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)) 12:51:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:51:46 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 12:51:46 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 12:51:46 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 12:51:46 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 12:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:51:48 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)) 12:51:48 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)) 12:51:48 INFO - Installing collected packages: simplejson 12:51:48 INFO - Running setup.py install for simplejson 12:51:48 INFO - building 'simplejson._speedups' extension 12:51:48 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 12:51:49 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 12:51:49 INFO - Successfully installed simplejson 12:51:49 INFO - Cleaning up... 12:51:49 INFO - Return code: 0 12:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51: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')]} 12:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b79b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, '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': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', '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 12:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:51:49 INFO - Using env: {'DISPLAY': ':0', 12:51:49 INFO - 'HOME': '/home/cltbld', 12:51:49 INFO - 'LANG': 'en_US.UTF-8', 12:51:49 INFO - 'LANGUAGE': 'en_US:en', 12:51:49 INFO - 'LOGNAME': 'cltbld', 12:51:49 INFO - 'MAIL': '/var/mail/cltbld', 12:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:49 INFO - 'MOZ_NO_REMOTE': '1', 12:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:49 INFO - 'NO_EM_RESTART': '1', 12:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:49 INFO - 'PWD': '/builds/slave/test', 12:51:49 INFO - 'SHELL': '/bin/bash', 12:51:49 INFO - 'SHLVL': '1', 12:51:49 INFO - 'TERM': 'linux', 12:51:49 INFO - 'TMOUT': '86400', 12:51:49 INFO - 'USER': 'cltbld', 12:51:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:49 INFO - '_': '/tools/buildbot/bin/python'} 12:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:51:49 INFO - Cleaning up... 12:51:49 INFO - Return code: 0 12:51:49 INFO - Running post-action listener: _resource_record_post_action 12:51:49 INFO - Running post-action listener: _start_resource_monitoring 12:51:49 INFO - Starting resource monitoring. 12:51:49 INFO - [mozharness: 2017-08-29 19:51:49.442472Z] Finished create-virtualenv step (success) 12:51:49 INFO - [mozharness: 2017-08-29 19:51:49.442943Z] Running install step. 12:51:49 INFO - Running pre-action listener: _resource_record_pre_action 12:51:49 INFO - Running main action method: install 12:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:49 INFO - Reading from file tmpfile_stdout 12:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:49 INFO - Reading from file tmpfile_stdout 12:51:49 INFO - Output received: 12:51:49 INFO - Usage: mozinstall [options] installer 12:51:49 INFO - Options: 12:51:49 INFO - -h, --help show this help message and exit 12:51:49 INFO - -d DEST, --destination=DEST 12:51:49 INFO - Directory to install application into. [default: 12:51:49 INFO - "/builds/slave/test"] 12:51:49 INFO - --app=APP Application being installed. [default: firefox] 12:51:49 INFO - mkdir: /builds/slave/test/build/application 12:51:49 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'] 12:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:52:06 INFO - Reading from file tmpfile_stdout 12:52:06 INFO - Output received: 12:52:06 INFO - /builds/slave/test/build/application/firefox/firefox 12:52:06 INFO - Running post-action listener: _resource_record_post_action 12:52:06 INFO - [mozharness: 2017-08-29 19:52:06.256397Z] Finished install step (success) 12:52:06 INFO - [mozharness: 2017-08-29 19:52:06.256649Z] Running setup-mitmproxy step. 12:52:06 INFO - Running pre-action listener: _resource_record_pre_action 12:52:06 INFO - Running main action method: setup_mitmproxy 12:52:06 INFO - Skipping: mitmproxy is not required 12:52:06 INFO - Running post-action listener: _resource_record_post_action 12:52:06 INFO - [mozharness: 2017-08-29 19:52:06.257766Z] Finished setup-mitmproxy step (success) 12:52:06 INFO - [mozharness: 2017-08-29 19:52:06.258008Z] Running run-tests step. 12:52:06 INFO - Running pre-action listener: _resource_record_pre_action 12:52:06 INFO - Running pre-action listener: _set_gcov_prefix 12:52:06 INFO - Running main action method: run_tests 12:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:52:06 INFO - Python 2.7.3 12:52:06 INFO - Return code: 0 12:52:06 INFO - grabbing minidump binary from tooltool 12:52: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')]} 12:52:06 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 0x2b76580>, '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 0x2b77480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b77910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:52:06 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 12:52:06 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 12:52:06 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 12:52:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:06 INFO - Return code: 0 12:52:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:52:06 INFO - ENV: RUST_BACKTRACE is now full 12:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:52:06 INFO - Using env: {'DISPLAY': ':0', 12:52:06 INFO - 'HOME': '/home/cltbld', 12:52:06 INFO - 'LANG': 'en_US.UTF-8', 12:52:06 INFO - 'LANGUAGE': 'en_US:en', 12:52:06 INFO - 'LOGNAME': 'cltbld', 12:52:06 INFO - 'MAIL': '/var/mail/cltbld', 12:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:52:06 INFO - 'MOZ_ACCELERATED': '1', 12:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:06 INFO - 'MOZ_NO_REMOTE': '1', 12:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:06 INFO - 'MOZ_WEBRENDER': '1', 12:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:06 INFO - 'NO_EM_RESTART': '1', 12:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:06 INFO - 'PWD': '/builds/slave/test', 12:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:06 INFO - 'RUST_BACKTRACE': 'full', 12:52:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:52:06 INFO - 'SHELL': '/bin/bash', 12:52:06 INFO - 'SHLVL': '1', 12:52:06 INFO - 'TERM': 'linux', 12:52:06 INFO - 'TMOUT': '86400', 12:52:06 INFO - 'USER': 'cltbld', 12:52:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:06 INFO - '_': '/tools/buildbot/bin/python'} 12:52:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:52:06 INFO - mozversion application_buildid: 20170829190058 12:52:06 INFO - mozversion application_changeset: 9957a25209908aaea4bfd4915c3201f006b29b6e 12:52:06 INFO - mozversion application_display_name: Nightly 12:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:06 INFO - mozversion application_name: Firefox 12:52:06 INFO - mozversion application_remotingname: firefox 12:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:52:06 INFO - mozversion application_vendor: Mozilla 12:52:06 INFO - mozversion application_version: 57.0a1 12:52:06 INFO - mozversion platform_buildid: 20170829190058 12:52:06 INFO - mozversion platform_changeset: 9957a25209908aaea4bfd4915c3201f006b29b6e 12:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:52:06 INFO - mozversion platform_version: 57.0a1 12:52:06 INFO - using testdate: 1504036326 12:52:06 INFO - actual date: 1504036326 12:52:06 INFO - starting webserver on 'localhost:57695' 12:52:06 INFO - SUITE-START | Running 2 tests 12:52:06 INFO - TEST-START | dromaeo_css 12:52:06 INFO - Initialising browser for dromaeo_css test... 12:52:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57695/getInfo.html -profile /tmp/tmpma7o87/profile 12:52:06 INFO - TEST-INFO | started process 4277 (/builds/slave/test/build/application/firefox/firefox http://localhost:57695/getInfo.html) 12:52:13 INFO - TEST-INFO | 4277: exit 0 12:52:14 INFO - Browser initialized. 12:52:14 INFO - Running cycle 1/1 for dromaeo_css test... 12:52:14 INFO - Using env: {'DISPLAY': ':0', 12:52:14 INFO - 'HOME': '/home/cltbld', 12:52:14 INFO - 'JSGC_DISABLE_POISONING': '1', 12:52:14 INFO - 'LANG': 'en_US.UTF-8', 12:52:14 INFO - 'LANGUAGE': 'en_US:en', 12:52:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:52:14 INFO - 'LOGNAME': 'cltbld', 12:52:14 INFO - 'MAIL': '/var/mail/cltbld', 12:52:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:52:14 INFO - 'MOZ_ACCELERATED': '1', 12:52:14 INFO - 'MOZ_CRASHREPORTER': '1', 12:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:52:14 INFO - 'MOZ_NO_REMOTE': '1', 12:52:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:14 INFO - 'MOZ_WEBRENDER': '1', 12:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:14 INFO - 'NO_EM_RESTART': '1', 12:52:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:14 INFO - 'PWD': '/builds/slave/test', 12:52:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:14 INFO - 'RUST_BACKTRACE': 'full', 12:52:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:52:14 INFO - 'SHELL': '/bin/bash', 12:52:14 INFO - 'SHLVL': '1', 12:52:14 INFO - 'TERM': 'linux', 12:52:14 INFO - 'TMOUT': '86400', 12:52:14 INFO - 'USER': 'cltbld', 12:52:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 12:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:14 INFO - '_': '/tools/buildbot/bin/python'} 12:52:14 INFO - TEST-INFO | started process 4474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpma7o87/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:15 INFO - PID 4474 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:52:15 INFO - PID 4474 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:52:15 INFO - PID 4474 | 12:52:15 INFO - PID 4474 | (/builds/slave/test/build/application/firefox/firefox:4535): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:52:15 INFO - PID 4474 | 12:52:25 INFO - PID 4474 | RSS: Main: 199725056 12:52:25 INFO - PID 4474 | 12:52:29 INFO - PID 4474 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:55:25 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:57695/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57695/tests/dromaeo/cssquery-ext.html) 12:55:26 INFO - PID 4474 | RSS: Main: 214110208 12:55:26 INFO - PID 4474 | 12:58:28 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:57695/tests/dromaeo/cssquery-ext.html (next: http://localhost:57695/tests/dromaeo/cssquery-jquery.html) 12:58:29 INFO - PID 4474 | RSS: Main: 210563072 12:58:29 INFO - PID 4474 | 13:01:31 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:57695/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57695/tests/dromaeo/cssquery-mootools.html) 13:01:31 INFO - PID 4474 | RSS: Main: 210173952 13:01:31 INFO - PID 4474 | 13:04:33 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:57695/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57695/tests/dromaeo/cssquery-prototype.html) 13:04:34 INFO - PID 4474 | RSS: Main: 212123648 13:04:34 INFO - PID 4474 | 13:07:38 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:57695/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57695/tests/dromaeo/cssquery-yui.html) 13:07:38 INFO - PID 4474 | RSS: Main: 212533248 13:07:38 INFO - PID 4474 | 13:10:40 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:57695/tests/dromaeo/cssquery-yui.html (next: http://localhost:57695/tests/dromaeo/cssquery-dojo.html) 13:10:41 INFO - PID 4474 | RSS: Main: 214917120 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | __start_tp_report 13:10:41 INFO - PID 4474 | _x_x_mozilla_page_load 13:10:41 INFO - PID 4474 | _x_x_mozilla_page_load_details 13:10:41 INFO - PID 4474 | |i|pagename|runs| 13:10:41 INFO - PID 4474 | |0;dojo.html;3282.4419848625716;3308.8345582720867;3317.1043818169096;3329.250918543328;3341.64912684168;6252.312245652986;6267.749290028399;6329.082283068958;6385.712642931067;6442.935570644292;6189.938100618992;6242.656653884034;6267.686615669221;6270.247570291572;6302.905456418157;5732.2548068751;5741.626794258381;5757.222774925394;5758.971205143989;5825.475707186352;5758.712064396785;5765.567582431314;5803.82588522345;5830.4169583041785;5832;5847.210626565423;5856.180134781134;5858.297004359483;5876.970615146918;5882.941170588304;5733.971330143323;5819.418058194189;5849.298084229919;5857.8828423431505;5863.325717542473;5554.472325129106;5663.923854467679;5742.2247996520355;5819.388964158787;5840.415958404168;5524.921987428971;6212.81361559154;6260.342664020303;6337.936620633827;6352.237731472207;6719.462443004597;6726.93273067268;6744.7976560703255;6819.624920629363;6830.282820303846;6777.593344399352;6783;6859.588424694534;6877.071595334666;6892.655367231619;6382.106505089291;6383.329750376237;6386.074019267273;6400.103985442041;6402.967985160138;7016.964915175391;7073.929260707327;7098.787036388917;7102.502824802317;7115.786526404217;6629.469642428594;6647.933520664731;6693.230278518033;6731.192256929102;6761.966190169018;6579.046038324416;6737.056812046318;6770.898436523456;6788.830279243059;6867.2102708188195;6549.312322206195;6711.530192886451;6758.8648227036165;6787.117674702257;6791.388775010273;6732.091167692397;6874.2094659113845;6877.552959057645;6886.449084073262;6929.5842249465195;5315.813946511931;5346.117890548094;5377.7580008899695;5393.865153371119;5412.675239485643;4582.152301824173;4654.232051711498;4666.580007799314;4686.718796872198;4702.435707715096;5875.853103672443;5879.353271140171;5944;5983.760649574056;6020.759169633253;6736.360045795642;6880.759173429006;6907;6925.861482770317;6939.618320992293;5946.405359464019;5968.850778730566;5973.522118230531;6026.367231440723;6036.366181550961;5743.85640358986;5809;5814.127880817911;5886.735096920649;5892.734826932799;6569.540132190797;6624.668766561653;6639.070530125786;6639.601623902485;6670.166229221348;6869.244383117753;6879;6959.478039147186;6960.756373526902;6968.3728464438445;6496.382843629847;6568.6058836469965;6584.440322572444;6652.767153149616;6695.0292207628645;6514.250861150838;6581.243157037002;6700.296468870698;6803.591784492946;6804.081449004321;6768.08630834831;6811.284815094542;6836.589804611739;6863.450923926173;6870.828229294308;6499.155109835691;6573.934260657332;6639.601623902581;6665.833354166185;6675.966620166868;6620.139381880324;6645.867082658417;6646.60120392778;6716.361945615159;6737.461003119641;6383.648899310582;6466.159399278064;6473.579217350857;6479.222493300834;6660.200775906728;6523.086767852409;6610.10763546915;6612.041254018044;6691.130153080068;6739.797806065826;6363.331850155667;6391.424771770563;6430.582012169194;6431.906575882205;6441.420272175526 13:10:41 INFO - PID 4474 | |1;ext.html;816.848882956653;853.5646820121738;878.6134100995557;887.2325438495701;1141.3893566941688;29974.850125749366;31030.224244393874;39841.80079099608;41117.38323925144;41129;41061.38407923884;41230.38154427686;41246.7937660312;41404.171916561725;41550.79224603873;5922.348541660435;5982.73077711504;6081.817545473643;7715.6142192890275;7873.724419645314;7464.178940316561;7718.189590093044;7746.535207887545;7754.651040703154;7779.222077792204;7639.19788422216;7731;7737.57443340616;7808.687652493893;7809.258120478546;7705.922940770604;7729.61351932404;7732.574708391036;7751.147373788879;7758.495697779626;7674.117476490163;7704.9598304228775;7749.380049596019;7757.146713861471;7766.495177813481;37144.25711485755;37405.43891841624;37406.625933740586;37465;37494.43758343627;3523.5067090607336;3546.113471632092;3547.0600290922926;3549.94675079874;3551.6803487686234;31014.224644383845;31191.064268071994;31287.530687039714;31318.21704457384;31352.843235783675;5181.844544663666;5189.506996835295;5227.843164705065;5231.633785635007;5253.264542963988;174155;174701.99999999872;175292.12353938277;176233;176503;46677;46749.76625116853;46785.06429871452;46825.06349872983;46863.29705054427;49739;50031.499685003415;50290;53067.20399194015;53629;15784;15993.28030238642;16171.110588917487;16182.271797769128;16275.104869232306;11844.940775296069;11951.462184201731;13250.801237981437;13333.20000799955;13361.26513041792;14323.78514322286;14330.426782928775;14417;14548.781768273484;14603;5807.274090738658;5820.097884827858;5829.125631155361;5915.260592425947;5941.108833674897;1014.4927536231884;1024.1653052761976;1033.6743925663393;1034.8085604163255;1037.4138611684375;22965.540689186124;23340.64989025166;23562.29313120609;23836.642450362913;23858.52282954331;1103.8896110388896;1119.1674825192085;1129.728865072393;1139.549877798265;1141.4692168141853;12252.448639811051;12436.56472023493;12492.375381230902;12501;12527.624171274694;228339;229262;231583;231611;232175;52953.2057019145;53284.467155328726;53290.46709532855;53317;53397;1310.7837206860952;1359.4833963094159;1360.2314692198877;1362.346073884541;1444.2922967745728;22519.66220506661;23173.073077077403;23178.76821231766;23201.3039608812;23406.882965585064;38482.61517384902;38774.61225387823;38844.41733374058;38869.416958745074;39015.80492097521;188918;189608;189829;190169;190463;32495.512567311038;33746.83126584352;33796.3240735179;33920;34089;41624.79187604043;41966.531171410075;41976.790116049226;42447.3632895513;42580;30865.537016944316;30989.535156973114;31356.372872541964;31638.209044774067;31687.52468713017;30357.39285214239;30709.539356909216;30881;30998.380032399677;31656.208594785316;34940.65059349374;34995;35221.29557408889;35250.11874703153;35594.64405355913;30740.231494212825;30782.53826192564;31007.84496077505;31194.532082019243;31237.68762312348;23084.83649947062;23128.421789454726;23511.412214694086;23539.29382118539;23625.40936476602 13:10:41 INFO - PID 4474 | |2;jquery.html;530.9283246761686;539.1831375466166;541.9945800541993;572.9512991395733;589.8053642298041;21592.352229433123;22459.21392751254;22615.095396184133;22648.320550383472;22659.433514162134;24545.140920067803;25474.74525254747;25607.487850242986;25642.102526411534;25678.101266455677;6606.8017959461295;6769.153855768029;6775.356341147608;6783.389494945454;6802.217744959344;6571.112899758519;6608.107905432753;6612.933870661304;6648.867022659568;6656.968169933668;6206.844828879269;6516.869662606745;6762.69567869447;6801.149856267966;6804.795856124324;6728.596284222938;6730.125083739107;6748.055272261888;6768.255491895888;6771.052052712625;6225.688715564249;6251.062340648894;6251.593646412968;6256.249250090018;6258.906116408258;28134.296642583893;29193;29243.853780731173;29552.113436596937;29765.404691906257;1982.474644219283;2022.4135000849735;2042.7344445222027;2045.7238272833126;2045.94885127873;19498.025098745147;20092.59814803696;20116.79883201164;20147.89926050375;20210.797892021186;2435.172041505879;2490.8380955237853;2520.395105174763;2521.596544552881;2545.618157276405;129989;134257.32871335678;134278;134353.32823335822;134621.3268933649;13743.931280343535;14221.644458888404;14324.713505730035;14603.488877889224;15096.471623493344;22372.105115795184;22423.775762242494;22490.21284255043;22505.636908124412;22590.322290331318;9839.262055345878;10197.677599025406;10234.692959211236;10399.84400233997;10410.947945260225;9502.619895204114;9575.904240957641;9628.951855240679;9672.70981870545;9780.41317520951;8878.511681857432;8895.4662720237;9057;9125.17873391398;9239.584218710173;2698.1770559979395;2780.708025657317;2810.3114736889183;2845.146456063173;2903.201619554597;952.4333021851987;982.4694664881027;991.9950400248097;995.1740055753708;997.2122023601419;19509.902450487658;20327.18691252363;23132.421689457562;23739.287821365386;24704.50590988206;1043.2488608202082;1059.0944742245424;1072.131573425528;1079.384750692098;1083.4420273559124;11187.328760274248;11341.659750207507;11377.37424441647;11505.367204803817;11622.186446948801;494616;522182;527168;527390;529493;112978;114187;115037.4248128754;116655;117367.41316293535;1238.219921449481;1250.2935841249664;1279.2899940532907;1281.2056524954587;1283.6983308922584;18222.18000190021;18778.436646900616;18847.434576962714;18878.15048322801;19333.323333683253;54935.72532137474;57265;58083;58274.4172558269;58557.4144258552;70566.29433705597;70977.29022709707;71401.28598714154;71832;72317;14188.503402380868;14459.710805784036;14487.492937747129;14497.710045798814;14542.701000831832;18008.36970706019;19035.143418546475;19481.415557533295;23581.764182357958;23594.88202559045;17791.021493817963;17838;17861.106944652976;17986.5503362417;18317.54206144804;16335.59161020984;16583.585410364354;16610.418635347705;16797.076160811273;16895.32418703238;18672.81327186765;19057.618847623246;19072.427827165207;19088.713669295248;19301.03494825281;14088.436462541384;14095.224762638154;14099.224542650252;14114.929425352808;14134;17495.300187992845;17983;18443.81556184421;18452.815471845646;18474 13:10:41 INFO - PID 4474 | |3;mootools.html;1339.7789364754813;1398.8461269260386;1399.9440022399106;1415.4409008441662;1417.461364681421;14218.857811421896;14879.776803347959;14895.77656335156;14906.850931490682;14995.175265360402;14108.717825643507;14718.779218311734;14740.557783266493;14752;14765;2721.4693134838762;2743.0947787230266;2798.0626490125833;2800.3979144483933;2800.425912687894;2655.0972669292437;2752.4632696624167;2757.510944090189;2763.157237042701;2765.2948498132946;2338.2985104468676;2445.070873068232;2618.0967566189634;2707.8646067696636;2714.742099500554;2610.7389261073836;2614.111202191245;2638.7097419283864;2649.218480548243;2650.9204723858315;2620.580707086876;2649.8277611955355;2657.906973255946;2659.5079910216477;2660.9467810643873;13996.440142394293;14030.158190508602;14204.360803763855;14284.500042498566;14294.070885392417;7666.195049519776;7883.408744344197;8011.879821802678;8076.152004039609;8208.015038195455;5361.463853614647;5459.181122831567;5540.722963851791;5640.04119299716;5658.971705141448;1757.903315317657;1778.262021261175;1806.14208251081;1847.9076046197636;1855.7587513623278;21921.561568768535;22402.327930162122;22429.21497747571;24850.00599975999;25051.999999999818;6628.966855165693;6671.666416679243;6743.831404214934;6809.897851532231;6953.200381956039;15580.454684086002;15615.531534053996;15670.608234794221;15716.135612541191;15731.528054158394;7734.651940662684;7913.485623434458;7993.280604745601;8004.239597238369;8011.639476223468;7321.78034658961;7378.594177320191;7452.366548843301;7467.402607791364;7537.095548534211;5197.376314842243;5345.65253258537;5359.812406565751;5395.4604539545735;5416.485433883775;1576.8896177267711;1578.3134336563633;1587.745960646291;1591.3475475055172;1600.4638446120448;874.2175752701297;905.5608030105394;908.4458480326995;909.8043920556979;922.4419226367951;7653.9234607654325;7708;8551.74344769658;8586.270167035747;8762.255208307237;712.1240873725346;713.8536599997092;716.9605671688003;718.8310746974457;728.5665029307554;5182.274481572583;5239.266502689627;5259.921101183485;5293.7353132344;5320.414754377015;20022.69965950512;20594.485137871674;20602;20724.481887952923;20785.1685932561;19659.705104423447;19988.900610466564;20040.198392064445;20057.39827805168;20079.39761807148;10804;10842.837357439645;10977.3962432067;11087;11138.832917506083;8312.83374332522;8535.786605334668;8572.099929507312;8574.905731899597;8622.396432249683;17296.740548892027;17652;18011.099445027434;18126.365577204735;18320.358787442376;17187;17459.56351091233;18062.36781712634;18687.813121869152;18887;11420.942895285803;11538.769224615293;11573.421328933688;11650.825237621273;11686.883131168579;13104.475820967054;13260.734785304432;13277.80083298732;13282.269475178959;13285.13646612967;10589.523471443958;10686.519106640375;10747.623833165802;10830.945845270724;10901.127909767041;10187.592496300065;10351.792964140826;10437.478126093512;10593.576256949636;10628.52171652262;8673.13268673153;8898.11018898105;8973.7756556084;8981.326400519856;9152;7046.365827075588;7077.256888026889;7082.822929426599;7106.467014974001;7233.782986510413;6588.637624930675;6622.668866556556;6664.400203981665;6714.0600315954825;6738.7304507819135 13:10:41 INFO - PID 4474 | |4;prototype.html;502.5200933108881;520.7110053920076;521.2233771680196;522.2583930818238;523.9318888544489;6407.455366293865;6430.633672664064;6480;6487.708053137609;6505.57713748606;6247.6251424914535;6279.466245369138;6351.364863513658;6367.395097465745;6388;4862.173430516803;5036.1438555445475;5178.766955487012;5236.554892834114;5243.711595862226;5003.374578177728;5051;5090.745462726867;5094.592432605401;5122.082800511514;5017.64876458648;5065.138926382524;5067.543921047105;5081.212412076134;5081.8221362252325;5013.373328333958;5021.974890125544;5032.345795046657;5066.36670416198;5074.619403544749;4505.346724724929;4543.31850222466;4549.45406551216;4552.635789136861;4582.266837306049;6195.752169913243;6260.749570017194;6264.185655864754;6265.342139075423;6331.176946996861;5674.546036317126;5714.342850572196;5716.314042314907;5719;5759.568032397545;6600.60396376219;6645.833854153685;6662.833429164261;6686.197656281229;6702.816162322906;4900.264960255954;4900.975495122537;4915.729634870081;4934.555889969884;4955.653104282702;6655.633940133339;6880.621565813828;6986.231514533397;7025.508214424993;7096.432285417154;4975.353204083446;4993.625478089158;5011.498850115032;5013.593475131885;5022.271770593316;4971.875703107451;5118.385793704705;5119.718415487109;5126.15418455958;5168.276441298146;5555.166724991283;5575.275214222125;5676.517496012885;5717.542596592346;5740.311162660424;6680.933190668031;6722.260551339349;6730.730770769114;6732.831679207961;6850.554713943678;1748.7814023247095;1783.28668532588;1785.276962830056;1790.9283628654707;1798.3705703004105;1190.6249531397582;1233.2600439736086;1247.1332423965257;1257.2142410993129;1261.8801213884667;5931.169636250928;5943.435373639497;5949.464548190684;5967.37342579023;6026.457618814327;6708.2956289589865;6774.7967560972265;6915.757948471779;6973.860522789516;6984.301569843076;5953.523718102541;5957.49361304294;5959.612625179349;5990.292766561509;6001.489873360726;3612.096975756061;3645.708343332527;3670.944935825965;3720.516332876763;3725.2177042821313;6597.439217666456;6603.867922641521;6614.603123812491;6638.879726528524;6695.631740254235;6989.671962327243;7031.3983825984715;7111.324424179695;7136.964315178495;7137.357637812518;6281.183446152062;6618.30507796684;6628.138342015507;6675.566088204251;6742.595444273359;6604.867902642017;6723.798286051427;6839.281875403011;6845.965770171118;6869.965650171717;6591.967040164768;6653.434458071119;6707.66461676924;6774.356436138559;6777.01733248686;6334.968325158345;6360.946745562249;6424.743010279536;6502.772402965874;6622.205335359788;4976.427710813158;4996.200607902718;5009.674371165863;5031.396232452129;5046.444891062054;6611.570247933869;6850.8287292816085;6870.862582748417;6888.897776355759;6999.755008574675;6454.548181627241;6472.73781612581;6578.342165783383;6621.431212463385;6673.866522669422;6623.933760662332;6635.777014699936;6655.767048153291;6665.83335416599;6690.799276021728;6507;6564.934350656432;6615.791341199418;6626.867462650816;6670.433013193933;6782.593044417351;6785.321467853372;6790.932090679227;6801.2858649841055;6842.24735279109;6385.584936979081;6409.839754006187;6415.133956915944;6498.3826536478955;6516.706748196248 13:10:41 INFO - PID 4474 | |5;yui.html;886.5035580075154;908.2143945487154;924.2375040591513;930.3719989007418;935.5415846235345;16103.35586576537;18917.24331026759;21862.23482178124;21993.120275188972;22198.667019994693;19166.32917847872;19400.805991940077;19490;19534.31629892954;19751.20995160192;964.2141654551518;972.6158167523823;980.8921018687938;984.3257368702461;987.3631507677544;944.5466176235411;987.210231814549;1005.7234260578326;1010.5200029985772;1011.4841430870273;1055.1137044882298;1060.0300724836804;1064.9627263045795;1068.0761141612488;1069.828827387618;1053.5996321397859;1055.4828134214256;1063.2557209953025;1063.7340664833791;1064.6593090211175;777.0713996773858;779.0729032451364;779.3219898688178;779.7621725373758;780.060027666666;16074.5981350466;17075.316987320493;19130.617387652168;19293;19316.613667726568;20989.79010209909;21315.5736885263;21704.782952170433;21859.12563497458;21943.67084493734;16618.916905415397;16996.745048824276;17210.139493025425;17238.138093095295;17273.91363043177;3731.2910546996254;3743.906402339936;3748.83130259139;3762.6049264827348;3763.41667041609;116757;118389;119122;123510;129463.99999999905;15681.529554113395;15775.684486310209;16299.185040747916;16373.345066197457;16407.261673224493;24688.50622987566;27129.321766955985;27364.863175684393;27397.315067123083;27443.588346174824;7654.311111999836;7756.767296981099;8221.095679475253;9381.953090234641;9401.952990235142;4189.560096189917;4293.377460268243;4300.698951073395;4319.07139964909;4319.287317592625;5079.847604571869;5121.718305493159;5131.230315452712;5203.843884683465;5246.895062098813;1026.2867307221409;1034.2605037398146;1053.1206442620344;1055.6199768083484;1056.804491169136;651.547174713579;671.419222372654;679.2392520377209;683.9692213850388;684.3464491410691;11609.501315743577;12192.329421881881;12355.25868447896;13087.018473614517;13589.980751443483;627.5293529852611;641.1824923222928;641.4066988036142;644.7517705683346;652.2499126005038;5573.136163894522;6285.9057114143325;6399.520035997226;6404.935950640527;6582.506312026617;110142;112205;112443;112834.43582782197;113231.43384283026;96454;96870.51564742273;99924.50037749765;100004.49997749965;100151.49924250333;81225.59387203027;82008.17991820005;85372.14627853766;85993.57003214944;86166;12054.51781928713;12702.618921432371;12850.935745321214;12862.0353473488;13040.478380864659;39334.60665393309;39411;39602.801985989885;40203.39694904637;40868.79565602153;67966.66016669886;70922;72079.27920720726;73128.63435682788;73728;17836.19737111859;17883;17884.463466096036;17966.640667186322;18039.819601803814;21352.572948541252;21396.358109256747;22076.668849966944;22094.558108838053;22887.08451661915;18080.819191807914;18516.537086572403;18651.90674046621;19077.236910523425;19129.713054303917;17461.12694365302;18583.72124418162;19587.412377628694;19914.402567922985;19971;18985.810141898957;19042.523936901132;19304.517387064872;19357.70963435578;19584;13397.665058373228;13844.238566878917;13875.72248555003;13913.791293130409;14167.574972750834;14375.209363485108;14590.416383344547;14778.704425911637;14864.62838429048;15145.545633631009 13:10:41 INFO - PID 4474 | __end_tp_report 13:10:41 INFO - PID 4474 | __start_cc_report 13:10:41 INFO - PID 4474 | _x_x_mozilla_cycle_collect,389 13:10:41 INFO - PID 4474 | __end_cc_report 13:10:41 INFO - PID 4474 | __startTimestamp1504037441197__endTimestamp 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | ------- Summary: start ------- 13:10:41 INFO - PID 4474 | Number of tests: 6 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | [#0] dojo.html Cycles:165 Average:6250.72 Median:6473.58 stddev:742.45 (11.5%) stddev-sans-first:707.27 13:10:41 INFO - PID 4474 | Values: 3282.4 3308.8 3317.1 3329.3 3341.6 6252.3 6267.7 6329.1 6385.7 6442.9 6189.9 6242.7 6267.7 6270.2 6302.9 5732.3 5741.6 5757.2 5759.0 5825.5 5758.7 5765.6 5803.8 5830.4 5832.0 5847.2 5856.2 5858.3 5877.0 5882.9 5734.0 5819.4 5849.3 5857.9 5863.3 5554.5 5663.9 5742.2 5819.4 5840.4 5524.9 6212.8 6260.3 6337.9 6352.2 6719.5 6726.9 6744.8 6819.6 6830.3 6777.6 6783.0 6859.6 6877.1 6892.7 6382.1 6383.3 6386.1 6400.1 6403.0 7017.0 7073.9 7098.8 7102.5 7115.8 6629.5 6647.9 6693.2 6731.2 6762.0 6579.0 6737.1 6770.9 6788.8 6867.2 6549.3 6711.5 6758.9 6787.1 6791.4 6732.1 6874.2 6877.6 6886.4 6929.6 5315.8 5346.1 5377.8 5393.9 5412.7 4582.2 4654.2 4666.6 4686.7 4702.4 5875.9 5879.4 5944.0 5983.8 6020.8 6736.4 6880.8 6907.0 6925.9 6939.6 5946.4 5968.9 5973.5 6026.4 6036.4 5743.9 5809.0 5814.1 5886.7 5892.7 6569.5 6624.7 6639.1 6639.6 6670.2 6869.2 6879.0 6959.5 6960.8 6968.4 6496.4 6568.6 6584.4 6652.8 6695.0 6514.3 6581.2 6700.3 6803.6 6804.1 6768.1 6811.3 6836.6 6863.5 6870.8 6499.2 6573.9 6639.6 6665.8 6676.0 6620.1 6645.9 6646.6 6716.4 6737.5 6383.6 6466.2 6473.6 6479.2 6660.2 6523.1 6610.1 6612.0 6691.1 6739.8 6363.3 6391.4 6430.6 6431.9 6441.4 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | [#1] ext.html Cycles:180 Average:36639.21 Median:33858.16 stddev:51801.46 (153.0%) stddev-sans-first:51876.94 13:10:41 INFO - PID 4474 | Values: 816.8 853.6 878.6 887.2 1141.4 29974.9 31030.2 39841.8 41117.4 41129.0 41061.4 41230.4 41246.8 41404.2 41550.8 5922.3 5982.7 6081.8 7715.6 7873.7 7464.2 7718.2 7746.5 7754.7 7779.2 7639.2 7731.0 7737.6 7808.7 7809.3 7705.9 7729.6 7732.6 7751.1 7758.5 7674.1 7705.0 7749.4 7757.1 7766.5 37144.3 37405.4 37406.6 37465.0 37494.4 3523.5 3546.1 3547.1 3549.9 3551.7 31014.2 31191.1 31287.5 31318.2 31352.8 5181.8 5189.5 5227.8 5231.6 5253.3 174155.0 174702.0 175292.1 176233.0 176503.0 46677.0 46749.8 46785.1 46825.1 46863.3 49739.0 50031.5 50290.0 53067.2 53629.0 15784.0 15993.3 16171.1 16182.3 16275.1 11844.9 11951.5 13250.8 13333.2 13361.3 14323.8 14330.4 14417.0 14548.8 14603.0 5807.3 5820.1 5829.1 5915.3 5941.1 1014.5 1024.2 1033.7 1034.8 1037.4 22965.5 23340.6 23562.3 23836.6 23858.5 1103.9 1119.2 1129.7 1139.5 1141.5 12252.4 12436.6 12492.4 12501.0 12527.6 228339.0 229262.0 231583.0 231611.0 232175.0 52953.2 53284.5 53290.5 53317.0 53397.0 1310.8 1359.5 1360.2 1362.3 1444.3 22519.7 23173.1 23178.8 23201.3 23406.9 38482.6 38774.6 38844.4 38869.4 39015.8 188918.0 189608.0 189829.0 190169.0 190463.0 32495.5 33746.8 33796.3 33920.0 34089.0 41624.8 41966.5 41976.8 42447.4 42580.0 30865.5 30989.5 31356.4 31638.2 31687.5 30357.4 30709.5 30881.0 30998.4 31656.2 34940.7 34995.0 35221.3 35250.1 35594.6 30740.2 30782.5 31007.8 31194.5 31237.7 23084.8 23128.4 23511.4 23539.3 23625.4 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | [#2] jquery.html Cycles:180 Average:35507.86 Median:22602.71 stddev:87103.73 (385.4%) stddev-sans-first:87308.49 13:10:41 INFO - PID 4474 | Values: 530.9 539.2 542.0 573.0 589.8 21592.4 22459.2 22615.1 22648.3 22659.4 24545.1 25474.7 25607.5 25642.1 25678.1 6606.8 6769.2 6775.4 6783.4 6802.2 6571.1 6608.1 6612.9 6648.9 6657.0 6206.8 6516.9 6762.7 6801.1 6804.8 6728.6 6730.1 6748.1 6768.3 6771.1 6225.7 6251.1 6251.6 6256.2 6258.9 28134.3 29193.0 29243.9 29552.1 29765.4 1982.5 2022.4 2042.7 2045.7 2045.9 19498.0 20092.6 20116.8 20147.9 20210.8 2435.2 2490.8 2520.4 2521.6 2545.6 129989.0 134257.3 134278.0 134353.3 134621.3 13743.9 14221.6 14324.7 14603.5 15096.5 22372.1 22423.8 22490.2 22505.6 22590.3 9839.3 10197.7 10234.7 10399.8 10410.9 9502.6 9575.9 9629.0 9672.7 9780.4 8878.5 8895.5 9057.0 9125.2 9239.6 2698.2 2780.7 2810.3 2845.1 2903.2 952.4 982.5 992.0 995.2 997.2 19509.9 20327.2 23132.4 23739.3 24704.5 1043.2 1059.1 1072.1 1079.4 1083.4 11187.3 11341.7 11377.4 11505.4 11622.2 494616.0 522182.0 527168.0 527390.0 529493.0 112978.0 114187.0 115037.4 116655.0 117367.4 1238.2 1250.3 1279.3 1281.2 1283.7 18222.2 18778.4 18847.4 18878.2 19333.3 54935.7 57265.0 58083.0 58274.4 58557.4 70566.3 70977.3 71401.3 71832.0 72317.0 14188.5 14459.7 14487.5 14497.7 14542.7 18008.4 19035.1 19481.4 23581.8 23594.9 17791.0 17838.0 17861.1 17986.6 18317.5 16335.6 16583.6 16610.4 16797.1 16895.3 18672.8 19057.6 19072.4 19088.7 19301.0 14088.4 14095.2 14099.2 14114.9 14134.0 17495.3 17983.0 18443.8 18452.8 18474.0 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | [#3] mootools.html Cycles:180 Average:8929.56 Median:2629.65 stddev:6141.10 (233.5%) stddev-sans-first:6131.85 13:10:41 INFO - PID 4474 | Values: 1339.8 1398.8 1399.9 1415.4 1417.5 14218.9 14879.8 14895.8 14906.9 14995.2 14108.7 14718.8 14740.6 14752.0 14765.0 2721.5 2743.1 2798.1 2800.4 2800.4 2655.1 2752.5 2757.5 2763.2 2765.3 2338.3 2445.1 2618.1 2707.9 2714.7 2610.7 2614.1 2638.7 2649.2 2650.9 2620.6 2649.8 2657.9 2659.5 2660.9 13996.4 14030.2 14204.4 14284.5 14294.1 7666.2 7883.4 8011.9 8076.2 8208.0 5361.5 5459.2 5540.7 5640.0 5659.0 1757.9 1778.3 1806.1 1847.9 1855.8 21921.6 22402.3 22429.2 24850.0 25052.0 6629.0 6671.7 6743.8 6809.9 6953.2 15580.5 15615.5 15670.6 15716.1 15731.5 7734.7 7913.5 7993.3 8004.2 8011.6 7321.8 7378.6 7452.4 7467.4 7537.1 5197.4 5345.7 5359.8 5395.5 5416.5 1576.9 1578.3 1587.7 1591.3 1600.5 874.2 905.6 908.4 909.8 922.4 7653.9 7708.0 8551.7 8586.3 8762.3 712.1 713.9 717.0 718.8 728.6 5182.3 5239.3 5259.9 5293.7 5320.4 20022.7 20594.5 20602.0 20724.5 20785.2 19659.7 19988.9 20040.2 20057.4 20079.4 10804.0 10842.8 10977.4 11087.0 11138.8 8312.8 8535.8 8572.1 8574.9 8622.4 17296.7 17652.0 18011.1 18126.4 18320.4 17187.0 17459.6 18062.4 18687.8 18887.0 11420.9 11538.8 11573.4 11650.8 11686.9 13104.5 13260.7 13277.8 13282.3 13285.1 10589.5 10686.5 10747.6 10830.9 10901.1 10187.6 10351.8 10437.5 10593.6 10628.5 8673.1 8898.1 8973.8 8981.3 9152.0 7046.4 7077.3 7082.8 7106.5 7233.8 6588.6 6622.7 6664.4 6714.1 6738.7 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | [#4] prototype.html Cycles:180 Average:5604.87 Median:6280.32 stddev:1577.14 (25.1%) stddev-sans-first:1534.36 13:10:41 INFO - PID 4474 | Values: 502.5 520.7 521.2 522.3 523.9 6407.5 6430.6 6480.0 6487.7 6505.6 6247.6 6279.5 6351.4 6367.4 6388.0 4862.2 5036.1 5178.8 5236.6 5243.7 5003.4 5051.0 5090.7 5094.6 5122.1 5017.6 5065.1 5067.5 5081.2 5081.8 5013.4 5022.0 5032.3 5066.4 5074.6 4505.3 4543.3 4549.5 4552.6 4582.3 6195.8 6260.7 6264.2 6265.3 6331.2 5674.5 5714.3 5716.3 5719.0 5759.6 6600.6 6645.8 6662.8 6686.2 6702.8 4900.3 4901.0 4915.7 4934.6 4955.7 6655.6 6880.6 6986.2 7025.5 7096.4 4975.4 4993.6 5011.5 5013.6 5022.3 4971.9 5118.4 5119.7 5126.2 5168.3 5555.2 5575.3 5676.5 5717.5 5740.3 6680.9 6722.3 6730.7 6732.8 6850.6 1748.8 1783.3 1785.3 1790.9 1798.4 1190.6 1233.3 1247.1 1257.2 1261.9 5931.2 5943.4 5949.5 5967.4 6026.5 6708.3 6774.8 6915.8 6973.9 6984.3 5953.5 5957.5 5959.6 5990.3 6001.5 3612.1 3645.7 3670.9 3720.5 3725.2 6597.4 6603.9 6614.6 6638.9 6695.6 6989.7 7031.4 7111.3 7137.0 7137.4 6281.2 6618.3 6628.1 6675.6 6742.6 6604.9 6723.8 6839.3 6846.0 6870.0 6592.0 6653.4 6707.7 6774.4 6777.0 6335.0 6360.9 6424.7 6502.8 6622.2 4976.4 4996.2 5009.7 5031.4 5046.4 6611.6 6850.8 6870.9 6888.9 6999.8 6454.5 6472.7 6578.3 6621.4 6673.9 6623.9 6635.8 6655.8 6665.8 6690.8 6507.0 6564.9 6615.8 6626.9 6670.4 6782.6 6785.3 6790.9 6801.3 6842.2 6385.6 6409.8 6415.1 6498.4 6516.7 13:10:41 INFO - PID 4474 | 13:10:41 INFO - PID 4474 | [#5] yui.html Cycles:180 Average:23727.03 Median:19942.70 stddev:31838.29 (159.6%) stddev-sans-first:31881.41 13:10:41 INFO - PID 4474 | Values: 886.5 908.2 924.2 930.4 935.5 16103.4 18917.2 21862.2 21993.1 22198.7 19166.3 19400.8 19490.0 19534.3 19751.2 964.2 972.6 980.9 984.3 987.4 944.5 987.2 1005.7 1010.5 1011.5 1055.1 1060.0 1065.0 1068.1 1069.8 1053.6 1055.5 1063.3 1063.7 1064.7 777.1 779.1 779.3 779.8 780.1 16074.6 17075.3 19130.6 19293.0 19316.6 20989.8 21315.6 21704.8 21859.1 21943.7 16618.9 16996.7 17210.1 17238.1 17273.9 3731.3 3743.9 3748.8 3762.6 3763.4 116757.0 118389.0 119122.0 123510.0 129464.0 15681.5 15775.7 16299.2 16373.3 16407.3 24688.5 27129.3 27364.9 27397.3 27443.6 7654.3 7756.8 8221.1 9382.0 9402.0 4189.6 4293.4 4300.7 4319.1 4319.3 5079.8 5121.7 5131.2 5203.8 5246.9 1026.3 1034.3 1053.1 1055.6 1056.8 651.5 671.4 679.2 684.0 684.3 11609.5 12192.3 12355.3 13087.0 13590.0 627.5 641.2 641.4 644.8 652.2 5573.1 6285.9 6399.5 6404.9 6582.5 110142.0 112205.0 112443.0 112834.4 113231.4 96454.0 96870.5 99924.5 100004.5 100151.5 81225.6 82008.2 85372.1 85993.6 86166.0 12054.5 12702.6 12850.9 12862.0 13040.5 39334.6 39411.0 39602.8 40203.4 40868.8 67966.7 70922.0 72079.3 73128.6 73728.0 17836.2 17883.0 17884.5 17966.6 18039.8 21352.6 21396.4 22076.7 22094.6 22887.1 18080.8 18516.5 18651.9 19077.2 19129.7 17461.1 18583.7 19587.4 19914.4 19971.0 18985.8 19042.5 19304.5 19357.7 19584.0 13397.7 13844.2 13875.7 13913.8 14167.6 14375.2 14590.4 14778.7 14864.6 15145.5 13:10:41 INFO - PID 4474 | -------- Summary: end -------- 13:10:41 INFO - PID 4474 | 13:10:42 INFO - TEST-INFO | 4474: exit 0 13:10:42 INFO - TEST-OK | dromaeo_css | took 1115512ms 13:10:42 INFO - TEST-START | kraken 13:10:42 INFO - Initialising browser for kraken test... 13:10:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57695/getInfo.html -profile /tmp/tmpRU9dRl/profile 13:10:42 INFO - TEST-INFO | started process 4857 (/builds/slave/test/build/application/firefox/firefox http://localhost:57695/getInfo.html) 13:10:48 INFO - TEST-INFO | 4857: exit 0 13:10:48 INFO - Browser initialized. 13:10:48 INFO - Running cycle 1/1 for kraken test... 13:10:48 INFO - Using env: {'DISPLAY': ':0', 13:10:48 INFO - 'HOME': '/home/cltbld', 13:10:48 INFO - 'JSGC_DISABLE_POISONING': '1', 13:10:48 INFO - 'LANG': 'en_US.UTF-8', 13:10:48 INFO - 'LANGUAGE': 'en_US:en', 13:10:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:10:48 INFO - 'LOGNAME': 'cltbld', 13:10:48 INFO - 'MAIL': '/var/mail/cltbld', 13:10:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:48 INFO - 'MOZ_ACCELERATED': '1', 13:10:48 INFO - 'MOZ_CRASHREPORTER': '1', 13:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:10:48 INFO - 'MOZ_NO_REMOTE': '1', 13:10:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:48 INFO - 'MOZ_WEBRENDER': '1', 13:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:48 INFO - 'NO_EM_RESTART': '1', 13:10:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:48 INFO - 'PWD': '/builds/slave/test', 13:10:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:48 INFO - 'RUST_BACKTRACE': 'full', 13:10:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:10:48 INFO - 'SHELL': '/bin/bash', 13:10:48 INFO - 'SHLVL': '1', 13:10:48 INFO - 'TERM': 'linux', 13:10:48 INFO - 'TMOUT': '86400', 13:10:48 INFO - 'USER': 'cltbld', 13:10:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663', 13:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:48 INFO - '_': '/tools/buildbot/bin/python'} 13:10:48 INFO - TEST-INFO | started process 5053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRU9dRl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:49 INFO - PID 5053 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 13:10:49 INFO - PID 5053 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 13:10:49 INFO - PID 5053 | 13:10:49 INFO - PID 5053 | (/builds/slave/test/build/application/firefox/firefox:5113): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:10:49 INFO - PID 5053 | 13:11:00 INFO - PID 5053 | RSS: Main: 199004160 13:11:00 INFO - PID 5053 | 13:11:02 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57695/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:03 INFO - PID 5053 | RSS: Main: 205508608 13:11:03 INFO - PID 5053 | 13:11:06 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57695/tests/kraken/driver.html?testName=audio-dft) 13:11:07 INFO - PID 5053 | RSS: Main: 204509184 13:11:07 INFO - PID 5053 | 13:11:10 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57695/tests/kraken/driver.html?testName=audio-fft) 13:11:10 INFO - PID 5053 | RSS: Main: 200282112 13:11:10 INFO - PID 5053 | 13:11:12 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57695/tests/kraken/driver.html?testName=audio-oscillator) 13:11:13 INFO - PID 5053 | RSS: Main: 200892416 13:11:13 INFO - PID 5053 | 13:11:15 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57695/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:16 INFO - PID 5053 | RSS: Main: 200192000 13:11:16 INFO - PID 5053 | 13:11:19 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57695/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:20 INFO - PID 5053 | RSS: Main: 204800000 13:11:20 INFO - PID 5053 | 13:11:23 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57695/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:24 INFO - PID 5053 | RSS: Main: 203800576 13:11:24 INFO - PID 5053 | 13:11:27 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57695/tests/kraken/driver.html?testName=json-parse-financial) 13:11:27 INFO - PID 5053 | RSS: Main: 204791808 13:11:27 INFO - PID 5053 | 13:11:29 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57695/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:30 INFO - PID 5053 | RSS: Main: 203116544 13:11:30 INFO - PID 5053 | 13:11:31 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:32 INFO - PID 5053 | RSS: Main: 204189696 13:11:32 INFO - PID 5053 | 13:11:34 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:35 INFO - PID 5053 | RSS: Main: 203669504 13:11:35 INFO - PID 5053 | 13:11:37 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:38 INFO - PID 5053 | RSS: Main: 205172736 13:11:38 INFO - PID 5053 | 13:11:41 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:42 INFO - PID 5053 | RSS: Main: 204627968 13:11:42 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | Cycle 1(1): loaded http://localhost:57695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57695/tests/kraken/driver.html?testName=ai-astar) 13:11:44 INFO - PID 5053 | RSS: Main: 207142912 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | __start_tp_report 13:11:44 INFO - PID 5053 | _x_x_mozilla_page_load 13:11:44 INFO - PID 5053 | _x_x_mozilla_page_load_details 13:11:44 INFO - PID 5053 | |i|pagename|runs| 13:11:44 INFO - PID 5053 | |0;ai-astar;98;108;106;108;109;109;118;98;109;108 13:11:44 INFO - PID 5053 | |1;audio-beat-detection;144;134;159;184;122;154;147;119;176;116 13:11:44 INFO - PID 5053 | |2;audio-dft;165;166;175;171;171;175;164;162;164;162 13:11:44 INFO - PID 5053 | |3;audio-fft;79;74;73;168;76;76;78;88;99;77 13:11:44 INFO - PID 5053 | |4;audio-oscillator;82;79;127;80;87;84;135;80;81;124 13:11:44 INFO - PID 5053 | |5;imaging-gaussian-blur;115;117;114;115;114;114;115;123;115;115 13:11:44 INFO - PID 5053 | |6;imaging-darkroom;160;150;148;156;149;149;149;159;154;148 13:11:44 INFO - PID 5053 | |7;imaging-desaturate;99;97;96;95;96;100;95;95;101;105 13:11:44 INFO - PID 5053 | |8;json-parse-financial;54;52;52;53;54;54;54;53;52;53 13:11:44 INFO - PID 5053 | |9;json-stringify-tinderbox;39;39;41;38;38;39;38;43;45;41 13:11:44 INFO - PID 5053 | |10;stanford-crypto-aes;78;76;79;82;75;74;74;78;78;86 13:11:44 INFO - PID 5053 | |11;stanford-crypto-ccm;133;129;117;126;121;122;127;128;122;164 13:11:44 INFO - PID 5053 | |12;stanford-crypto-pbkdf2;174;174;173;177;175;181;175;176;179;188 13:11:44 INFO - PID 5053 | |13;stanford-crypto-sha256-iterative;65;75;65;64;65;68;65;70;66;65 13:11:44 INFO - PID 5053 | __end_tp_report 13:11:44 INFO - PID 5053 | __start_cc_report 13:11:44 INFO - PID 5053 | _x_x_mozilla_cycle_collect,925 13:11:44 INFO - PID 5053 | __end_cc_report 13:11:44 INFO - PID 5053 | __startTimestamp1504037504348__endTimestamp 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | ------- Summary: start ------- 13:11:44 INFO - PID 5053 | Number of tests: 14 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:5.76 (5.3%) stddev-sans-first:5.09 13:11:44 INFO - PID 5053 | Values: 98.0 108.0 106.0 108.0 109.0 109.0 118.0 98.0 109.0 108.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:150.50 stddev:23.40 (15.5%) stddev-sans-first:24.81 13:11:44 INFO - PID 5053 | Values: 144.0 134.0 159.0 184.0 122.0 154.0 147.0 119.0 176.0 116.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#2] audio-dft Cycles:10 Average:167.50 Median:168.50 stddev:5.06 (3.0%) stddev-sans-first:5.29 13:11:44 INFO - PID 5053 | Values: 165.0 166.0 175.0 171.0 171.0 175.0 164.0 162.0 164.0 162.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#3] audio-fft Cycles:10 Average:88.80 Median:77.50 stddev:28.92 (37.3%) stddev-sans-first:30.45 13:11:44 INFO - PID 5053 | Values: 79.0 74.0 73.0 168.0 76.0 76.0 78.0 88.0 99.0 77.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:80.50 stddev:22.88 (28.4%) stddev-sans-first:23.71 13:11:44 INFO - PID 5053 | Values: 82.0 79.0 127.0 80.0 87.0 84.0 135.0 80.0 81.0 124.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:2.71 (2.4%) stddev-sans-first:2.86 13:11:44 INFO - PID 5053 | Values: 115.0 117.0 114.0 115.0 114.0 114.0 115.0 123.0 115.0 115.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.00 stddev:4.66 (3.1%) stddev-sans-first:4.00 13:11:44 INFO - PID 5053 | Values: 160.0 150.0 148.0 156.0 149.0 149.0 149.0 159.0 154.0 148.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:95.50 stddev:3.31 (3.5%) stddev-sans-first:3.49 13:11:44 INFO - PID 5053 | Values: 99.0 97.0 96.0 95.0 96.0 100.0 95.0 95.0 101.0 105.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:0.88 (1.6%) stddev-sans-first:0.87 13:11:44 INFO - PID 5053 | Values: 54.0 52.0 52.0 53.0 54.0 54.0 54.0 53.0 52.0 53.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#9] json-stringify-tinderbox Cycles:10 Average:40.10 Median:40.00 stddev:2.38 (5.9%) stddev-sans-first:2.49 13:11:44 INFO - PID 5053 | Values: 39.0 39.0 41.0 38.0 38.0 39.0 38.0 43.0 45.0 41.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:3.74 (4.8%) stddev-sans-first:3.97 13:11:44 INFO - PID 5053 | Values: 78.0 76.0 79.0 82.0 75.0 74.0 74.0 78.0 78.0 86.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.50 stddev:13.17 (10.3%) stddev-sans-first:13.88 13:11:44 INFO - PID 5053 | Values: 133.0 129.0 117.0 126.0 121.0 122.0 127.0 128.0 122.0 164.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:176.50 stddev:4.52 (2.6%) stddev-sans-first:4.64 13:11:44 INFO - PID 5053 | Values: 174.0 174.0 173.0 177.0 175.0 181.0 175.0 176.0 179.0 188.0 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:65.50 stddev:3.39 (5.2%) stddev-sans-first:3.54 13:11:44 INFO - PID 5053 | Values: 65.0 75.0 65.0 64.0 65.0 68.0 65.0 70.0 66.0 65.0 13:11:44 INFO - PID 5053 | -------- Summary: end -------- 13:11:44 INFO - PID 5053 | 13:11:44 INFO - PID 5053 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:11:45 INFO - TEST-INFO | 5053: exit 0 13:11:45 INFO - TEST-OK | kraken | took 63137ms 13:11:45 INFO - SUITE-END | took 1178s 13:11:45 INFO - Completed test suite (00:19:38) 13:11:45 INFO - javascript benchmark 13:11:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8537.312192591653, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.4419848625716, 3308.8345582720867, 3317.1043818169096, 3329.250918543328, 3341.64912684168, 6252.312245652986, 6267.749290028399, 6329.082283068958, 6385.712642931067, 6442.935570644292, 6189.938100618992, 6242.656653884034, 6267.686615669221, 6270.247570291572, 6302.905456418157, 5732.2548068751, 5741.626794258381, 5757.222774925394, 5758.971205143989, 5825.475707186352, 5758.712064396785, 5765.567582431314, 5803.82588522345, 5830.4169583041785, 5832.0, 5847.210626565423, 5856.180134781134, 5858.297004359483, 5876.970615146918, 5882.941170588304, 5733.971330143323, 5819.418058194189, 5849.298084229919, 5857.8828423431505, 5863.325717542473, 5554.472325129106, 5663.923854467679, 5742.2247996520355, 5819.388964158787, 5840.415958404168, 5524.921987428971, 6212.81361559154, 6260.342664020303, 6337.936620633827, 6352.237731472207, 6719.462443004597, 6726.93273067268, 6744.7976560703255, 6819.624920629363, 6830.282820303846, 6777.593344399352, 6783.0, 6859.588424694534, 6877.071595334666, 6892.655367231619, 6382.106505089291, 6383.329750376237, 6386.074019267273, 6400.103985442041, 6402.967985160138, 7016.964915175391, 7073.929260707327, 7098.787036388917, 7102.502824802317, 7115.786526404217, 6629.469642428594, 6647.933520664731, 6693.230278518033, 6731.192256929102, 6761.966190169018, 6579.046038324416, 6737.056812046318, 6770.898436523456, 6788.830279243059, 6867.2102708188195, 6549.312322206195, 6711.530192886451, 6758.8648227036165, 6787.117674702257, 6791.388775010273, 6732.091167692397, 6874.2094659113845, 6877.552959057645, 6886.449084073262, 6929.5842249465195, 5315.813946511931, 5346.117890548094, 5377.7580008899695, 5393.865153371119, 5412.675239485643, 4582.152301824173, 4654.232051711498, 4666.580007799314, 4686.718796872198, 4702.435707715096, 5875.853103672443, 5879.353271140171, 5944.0, 5983.760649574056, 6020.759169633253, 6736.360045795642, 6880.759173429006, 6907.0, 6925.861482770317, 6939.618320992293, 5946.405359464019, 5968.850778730566, 5973.522118230531, 6026.367231440723, 6036.366181550961, 5743.85640358986, 5809.0, 5814.127880817911, 5886.735096920649, 5892.734826932799, 6569.540132190797, 6624.668766561653, 6639.070530125786, 6639.601623902485, 6670.166229221348, 6869.244383117753, 6879.0, 6959.478039147186, 6960.756373526902, 6968.3728464438445, 6496.382843629847, 6568.6058836469965, 6584.440322572444, 6652.767153149616, 6695.0292207628645, 6514.250861150838, 6581.243157037002, 6700.296468870698, 6803.591784492946, 6804.081449004321, 6768.08630834831, 6811.284815094542, 6836.589804611739, 6863.450923926173, 6870.828229294308, 6499.155109835691, 6573.934260657332, 6639.601623902581, 6665.833354166185, 6675.966620166868, 6620.139381880324, 6645.867082658417, 6646.60120392778, 6716.361945615159, 6737.461003119641, 6383.648899310582, 6466.159399278064, 6473.579217350857, 6479.222493300834, 6660.200775906728, 6523.086767852409, 6610.10763546915, 6612.041254018044, 6691.130153080068, 6739.797806065826, 6363.331850155667, 6391.424771770563, 6430.582012169194, 6431.906575882205, 6441.420272175526], "value": 6196.335299577853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.848882956653, 853.5646820121738, 878.6134100995557, 887.2325438495701, 1141.3893566941688, 29974.850125749366, 31030.224244393874, 39841.80079099608, 41117.38323925144, 41129.0, 41061.38407923884, 41230.38154427686, 41246.7937660312, 41404.171916561725, 41550.79224603873, 5922.348541660435, 5982.73077711504, 6081.817545473643, 7715.6142192890275, 7873.724419645314, 7464.178940316561, 7718.189590093044, 7746.535207887545, 7754.651040703154, 7779.222077792204, 7639.19788422216, 7731.0, 7737.57443340616, 7808.687652493893, 7809.258120478546, 7705.922940770604, 7729.61351932404, 7732.574708391036, 7751.147373788879, 7758.495697779626, 7674.117476490163, 7704.9598304228775, 7749.380049596019, 7757.146713861471, 7766.495177813481, 37144.25711485755, 37405.43891841624, 37406.625933740586, 37465.0, 37494.43758343627, 3523.5067090607336, 3546.113471632092, 3547.0600290922926, 3549.94675079874, 3551.6803487686234, 31014.224644383845, 31191.064268071994, 31287.530687039714, 31318.21704457384, 31352.843235783675, 5181.844544663666, 5189.506996835295, 5227.843164705065, 5231.633785635007, 5253.264542963988, 174155.0, 174701.99999999872, 175292.12353938277, 176233.0, 176503.0, 46677.0, 46749.76625116853, 46785.06429871452, 46825.06349872983, 46863.29705054427, 49739.0, 50031.499685003415, 50290.0, 53067.20399194015, 53629.0, 15784.0, 15993.28030238642, 16171.110588917487, 16182.271797769128, 16275.104869232306, 11844.940775296069, 11951.462184201731, 13250.801237981437, 13333.20000799955, 13361.26513041792, 14323.78514322286, 14330.426782928775, 14417.0, 14548.781768273484, 14603.0, 5807.274090738658, 5820.097884827858, 5829.125631155361, 5915.260592425947, 5941.108833674897, 1014.4927536231884, 1024.1653052761976, 1033.6743925663393, 1034.8085604163255, 1037.4138611684375, 22965.540689186124, 23340.64989025166, 23562.29313120609, 23836.642450362913, 23858.52282954331, 1103.8896110388896, 1119.1674825192085, 1129.728865072393, 1139.549877798265, 1141.4692168141853, 12252.448639811051, 12436.56472023493, 12492.375381230902, 12501.0, 12527.624171274694, 228339.0, 229262.0, 231583.0, 231611.0, 232175.0, 52953.2057019145, 53284.467155328726, 53290.46709532855, 53317.0, 53397.0, 1310.7837206860952, 1359.4833963094159, 1360.2314692198877, 1362.346073884541, 1444.2922967745728, 22519.66220506661, 23173.073077077403, 23178.76821231766, 23201.3039608812, 23406.882965585064, 38482.61517384902, 38774.61225387823, 38844.41733374058, 38869.416958745074, 39015.80492097521, 188918.0, 189608.0, 189829.0, 190169.0, 190463.0, 32495.512567311038, 33746.83126584352, 33796.3240735179, 33920.0, 34089.0, 41624.79187604043, 41966.531171410075, 41976.790116049226, 42447.3632895513, 42580.0, 30865.537016944316, 30989.535156973114, 31356.372872541964, 31638.209044774067, 31687.52468713017, 30357.39285214239, 30709.539356909216, 30881.0, 30998.380032399677, 31656.208594785316, 34940.65059349374, 34995.0, 35221.29557408889, 35250.11874703153, 35594.64405355913, 30740.231494212825, 30782.53826192564, 31007.84496077505, 31194.532082019243, 31237.68762312348, 23084.83649947062, 23128.421789454726, 23511.412214694086, 23539.29382118539, 23625.40936476602], "value": 16949.44091042666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.9283246761686, 539.1831375466166, 541.9945800541993, 572.9512991395733, 589.8053642298041, 21592.352229433123, 22459.21392751254, 22615.095396184133, 22648.320550383472, 22659.433514162134, 24545.140920067803, 25474.74525254747, 25607.487850242986, 25642.102526411534, 25678.101266455677, 6606.8017959461295, 6769.153855768029, 6775.356341147608, 6783.389494945454, 6802.217744959344, 6571.112899758519, 6608.107905432753, 6612.933870661304, 6648.867022659568, 6656.968169933668, 6206.844828879269, 6516.869662606745, 6762.69567869447, 6801.149856267966, 6804.795856124324, 6728.596284222938, 6730.125083739107, 6748.055272261888, 6768.255491895888, 6771.052052712625, 6225.688715564249, 6251.062340648894, 6251.593646412968, 6256.249250090018, 6258.906116408258, 28134.296642583893, 29193.0, 29243.853780731173, 29552.113436596937, 29765.404691906257, 1982.474644219283, 2022.4135000849735, 2042.7344445222027, 2045.7238272833126, 2045.94885127873, 19498.025098745147, 20092.59814803696, 20116.79883201164, 20147.89926050375, 20210.797892021186, 2435.172041505879, 2490.8380955237853, 2520.395105174763, 2521.596544552881, 2545.618157276405, 129989.0, 134257.32871335678, 134278.0, 134353.32823335822, 134621.3268933649, 13743.931280343535, 14221.644458888404, 14324.713505730035, 14603.488877889224, 15096.471623493344, 22372.105115795184, 22423.775762242494, 22490.21284255043, 22505.636908124412, 22590.322290331318, 9839.262055345878, 10197.677599025406, 10234.692959211236, 10399.84400233997, 10410.947945260225, 9502.619895204114, 9575.904240957641, 9628.951855240679, 9672.70981870545, 9780.41317520951, 8878.511681857432, 8895.4662720237, 9057.0, 9125.17873391398, 9239.584218710173, 2698.1770559979395, 2780.708025657317, 2810.3114736889183, 2845.146456063173, 2903.201619554597, 952.4333021851987, 982.4694664881027, 991.9950400248097, 995.1740055753708, 997.2122023601419, 19509.902450487658, 20327.18691252363, 23132.421689457562, 23739.287821365386, 24704.50590988206, 1043.2488608202082, 1059.0944742245424, 1072.131573425528, 1079.384750692098, 1083.4420273559124, 11187.328760274248, 11341.659750207507, 11377.37424441647, 11505.367204803817, 11622.186446948801, 494616.0, 522182.0, 527168.0, 527390.0, 529493.0, 112978.0, 114187.0, 115037.4248128754, 116655.0, 117367.41316293535, 1238.219921449481, 1250.2935841249664, 1279.2899940532907, 1281.2056524954587, 1283.6983308922584, 18222.18000190021, 18778.436646900616, 18847.434576962714, 18878.15048322801, 19333.323333683253, 54935.72532137474, 57265.0, 58083.0, 58274.4172558269, 58557.4144258552, 70566.29433705597, 70977.29022709707, 71401.28598714154, 71832.0, 72317.0, 14188.503402380868, 14459.710805784036, 14487.492937747129, 14497.710045798814, 14542.701000831832, 18008.36970706019, 19035.143418546475, 19481.415557533295, 23581.764182357958, 23594.88202559045, 17791.021493817963, 17838.0, 17861.106944652976, 17986.5503362417, 18317.54206144804, 16335.59161020984, 16583.585410364354, 16610.418635347705, 16797.076160811273, 16895.32418703238, 18672.81327186765, 19057.618847623246, 19072.427827165207, 19088.713669295248, 19301.03494825281, 14088.436462541384, 14095.224762638154, 14099.224542650252, 14114.929425352808, 14134.0, 17495.300187992845, 17983.0, 18443.81556184421, 18452.815471845646, 18474.0], "value": 12065.821616498992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.7789364754813, 1398.8461269260386, 1399.9440022399106, 1415.4409008441662, 1417.461364681421, 14218.857811421896, 14879.776803347959, 14895.77656335156, 14906.850931490682, 14995.175265360402, 14108.717825643507, 14718.779218311734, 14740.557783266493, 14752.0, 14765.0, 2721.4693134838762, 2743.0947787230266, 2798.0626490125833, 2800.3979144483933, 2800.425912687894, 2655.0972669292437, 2752.4632696624167, 2757.510944090189, 2763.157237042701, 2765.2948498132946, 2338.2985104468676, 2445.070873068232, 2618.0967566189634, 2707.8646067696636, 2714.742099500554, 2610.7389261073836, 2614.111202191245, 2638.7097419283864, 2649.218480548243, 2650.9204723858315, 2620.580707086876, 2649.8277611955355, 2657.906973255946, 2659.5079910216477, 2660.9467810643873, 13996.440142394293, 14030.158190508602, 14204.360803763855, 14284.500042498566, 14294.070885392417, 7666.195049519776, 7883.408744344197, 8011.879821802678, 8076.152004039609, 8208.015038195455, 5361.463853614647, 5459.181122831567, 5540.722963851791, 5640.04119299716, 5658.971705141448, 1757.903315317657, 1778.262021261175, 1806.14208251081, 1847.9076046197636, 1855.7587513623278, 21921.561568768535, 22402.327930162122, 22429.21497747571, 24850.00599975999, 25051.999999999818, 6628.966855165693, 6671.666416679243, 6743.831404214934, 6809.897851532231, 6953.200381956039, 15580.454684086002, 15615.531534053996, 15670.608234794221, 15716.135612541191, 15731.528054158394, 7734.651940662684, 7913.485623434458, 7993.280604745601, 8004.239597238369, 8011.639476223468, 7321.78034658961, 7378.594177320191, 7452.366548843301, 7467.402607791364, 7537.095548534211, 5197.376314842243, 5345.65253258537, 5359.812406565751, 5395.4604539545735, 5416.485433883775, 1576.8896177267711, 1578.3134336563633, 1587.745960646291, 1591.3475475055172, 1600.4638446120448, 874.2175752701297, 905.5608030105394, 908.4458480326995, 909.8043920556979, 922.4419226367951, 7653.9234607654325, 7708.0, 8551.74344769658, 8586.270167035747, 8762.255208307237, 712.1240873725346, 713.8536599997092, 716.9605671688003, 718.8310746974457, 728.5665029307554, 5182.274481572583, 5239.266502689627, 5259.921101183485, 5293.7353132344, 5320.414754377015, 20022.69965950512, 20594.485137871674, 20602.0, 20724.481887952923, 20785.1685932561, 19659.705104423447, 19988.900610466564, 20040.198392064445, 20057.39827805168, 20079.39761807148, 10804.0, 10842.837357439645, 10977.3962432067, 11087.0, 11138.832917506083, 8312.83374332522, 8535.786605334668, 8572.099929507312, 8574.905731899597, 8622.396432249683, 17296.740548892027, 17652.0, 18011.099445027434, 18126.365577204735, 18320.358787442376, 17187.0, 17459.56351091233, 18062.36781712634, 18687.813121869152, 18887.0, 11420.942895285803, 11538.769224615293, 11573.421328933688, 11650.825237621273, 11686.883131168579, 13104.475820967054, 13260.734785304432, 13277.80083298732, 13282.269475178959, 13285.13646612967, 10589.523471443958, 10686.519106640375, 10747.623833165802, 10830.945845270724, 10901.127909767041, 10187.592496300065, 10351.792964140826, 10437.478126093512, 10593.576256949636, 10628.52171652262, 8673.13268673153, 8898.11018898105, 8973.7756556084, 8981.326400519856, 9152.0, 7046.365827075588, 7077.256888026889, 7082.822929426599, 7106.467014974001, 7233.782986510413, 6588.637624930675, 6622.668866556556, 6664.400203981665, 6714.0600315954825, 6738.7304507819135], "value": 6457.82908369184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.5200933108881, 520.7110053920076, 521.2233771680196, 522.2583930818238, 523.9318888544489, 6407.455366293865, 6430.633672664064, 6480.0, 6487.708053137609, 6505.57713748606, 6247.6251424914535, 6279.466245369138, 6351.364863513658, 6367.395097465745, 6388.0, 4862.173430516803, 5036.1438555445475, 5178.766955487012, 5236.554892834114, 5243.711595862226, 5003.374578177728, 5051.0, 5090.745462726867, 5094.592432605401, 5122.082800511514, 5017.64876458648, 5065.138926382524, 5067.543921047105, 5081.212412076134, 5081.8221362252325, 5013.373328333958, 5021.974890125544, 5032.345795046657, 5066.36670416198, 5074.619403544749, 4505.346724724929, 4543.31850222466, 4549.45406551216, 4552.635789136861, 4582.266837306049, 6195.752169913243, 6260.749570017194, 6264.185655864754, 6265.342139075423, 6331.176946996861, 5674.546036317126, 5714.342850572196, 5716.314042314907, 5719.0, 5759.568032397545, 6600.60396376219, 6645.833854153685, 6662.833429164261, 6686.197656281229, 6702.816162322906, 4900.264960255954, 4900.975495122537, 4915.729634870081, 4934.555889969884, 4955.653104282702, 6655.633940133339, 6880.621565813828, 6986.231514533397, 7025.508214424993, 7096.432285417154, 4975.353204083446, 4993.625478089158, 5011.498850115032, 5013.593475131885, 5022.271770593316, 4971.875703107451, 5118.385793704705, 5119.718415487109, 5126.15418455958, 5168.276441298146, 5555.166724991283, 5575.275214222125, 5676.517496012885, 5717.542596592346, 5740.311162660424, 6680.933190668031, 6722.260551339349, 6730.730770769114, 6732.831679207961, 6850.554713943678, 1748.7814023247095, 1783.28668532588, 1785.276962830056, 1790.9283628654707, 1798.3705703004105, 1190.6249531397582, 1233.2600439736086, 1247.1332423965257, 1257.2142410993129, 1261.8801213884667, 5931.169636250928, 5943.435373639497, 5949.464548190684, 5967.37342579023, 6026.457618814327, 6708.2956289589865, 6774.7967560972265, 6915.757948471779, 6973.860522789516, 6984.301569843076, 5953.523718102541, 5957.49361304294, 5959.612625179349, 5990.292766561509, 6001.489873360726, 3612.096975756061, 3645.708343332527, 3670.944935825965, 3720.516332876763, 3725.2177042821313, 6597.439217666456, 6603.867922641521, 6614.603123812491, 6638.879726528524, 6695.631740254235, 6989.671962327243, 7031.3983825984715, 7111.324424179695, 7136.964315178495, 7137.357637812518, 6281.183446152062, 6618.30507796684, 6628.138342015507, 6675.566088204251, 6742.595444273359, 6604.867902642017, 6723.798286051427, 6839.281875403011, 6845.965770171118, 6869.965650171717, 6591.967040164768, 6653.434458071119, 6707.66461676924, 6774.356436138559, 6777.01733248686, 6334.968325158345, 6360.946745562249, 6424.743010279536, 6502.772402965874, 6622.205335359788, 4976.427710813158, 4996.200607902718, 5009.674371165863, 5031.396232452129, 5046.444891062054, 6611.570247933869, 6850.8287292816085, 6870.862582748417, 6888.897776355759, 6999.755008574675, 6454.548181627241, 6472.73781612581, 6578.342165783383, 6621.431212463385, 6673.866522669422, 6623.933760662332, 6635.777014699936, 6655.767048153291, 6665.83335416599, 6690.799276021728, 6507.0, 6564.934350656432, 6615.791341199418, 6626.867462650816, 6670.433013193933, 6782.593044417351, 6785.321467853372, 6790.932090679227, 6801.2858649841055, 6842.24735279109, 6385.584936979081, 6409.839754006187, 6415.133956915944, 6498.3826536478955, 6516.706748196248], "value": 5139.945806017873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.5035580075154, 908.2143945487154, 924.2375040591513, 930.3719989007418, 935.5415846235345, 16103.35586576537, 18917.24331026759, 21862.23482178124, 21993.120275188972, 22198.667019994693, 19166.32917847872, 19400.805991940077, 19490.0, 19534.31629892954, 19751.20995160192, 964.2141654551518, 972.6158167523823, 980.8921018687938, 984.3257368702461, 987.3631507677544, 944.5466176235411, 987.210231814549, 1005.7234260578326, 1010.5200029985772, 1011.4841430870273, 1055.1137044882298, 1060.0300724836804, 1064.9627263045795, 1068.0761141612488, 1069.828827387618, 1053.5996321397859, 1055.4828134214256, 1063.2557209953025, 1063.7340664833791, 1064.6593090211175, 777.0713996773858, 779.0729032451364, 779.3219898688178, 779.7621725373758, 780.060027666666, 16074.5981350466, 17075.316987320493, 19130.617387652168, 19293.0, 19316.613667726568, 20989.79010209909, 21315.5736885263, 21704.782952170433, 21859.12563497458, 21943.67084493734, 16618.916905415397, 16996.745048824276, 17210.139493025425, 17238.138093095295, 17273.91363043177, 3731.2910546996254, 3743.906402339936, 3748.83130259139, 3762.6049264827348, 3763.41667041609, 116757.0, 118389.0, 119122.0, 123510.0, 129463.99999999905, 15681.529554113395, 15775.684486310209, 16299.185040747916, 16373.345066197457, 16407.261673224493, 24688.50622987566, 27129.321766955985, 27364.863175684393, 27397.315067123083, 27443.588346174824, 7654.311111999836, 7756.767296981099, 8221.095679475253, 9381.953090234641, 9401.952990235142, 4189.560096189917, 4293.377460268243, 4300.698951073395, 4319.07139964909, 4319.287317592625, 5079.847604571869, 5121.718305493159, 5131.230315452712, 5203.843884683465, 5246.895062098813, 1026.2867307221409, 1034.2605037398146, 1053.1206442620344, 1055.6199768083484, 1056.804491169136, 651.547174713579, 671.419222372654, 679.2392520377209, 683.9692213850388, 684.3464491410691, 11609.501315743577, 12192.329421881881, 12355.25868447896, 13087.018473614517, 13589.980751443483, 627.5293529852611, 641.1824923222928, 641.4066988036142, 644.7517705683346, 652.2499126005038, 5573.136163894522, 6285.9057114143325, 6399.520035997226, 6404.935950640527, 6582.506312026617, 110142.0, 112205.0, 112443.0, 112834.43582782197, 113231.43384283026, 96454.0, 96870.51564742273, 99924.50037749765, 100004.49997749965, 100151.49924250333, 81225.59387203027, 82008.17991820005, 85372.14627853766, 85993.57003214944, 86166.0, 12054.51781928713, 12702.618921432371, 12850.935745321214, 12862.0353473488, 13040.478380864659, 39334.60665393309, 39411.0, 39602.801985989885, 40203.39694904637, 40868.79565602153, 67966.66016669886, 70922.0, 72079.27920720726, 73128.63435682788, 73728.0, 17836.19737111859, 17883.0, 17884.463466096036, 17966.640667186322, 18039.819601803814, 21352.572948541252, 21396.358109256747, 22076.668849966944, 22094.558108838053, 22887.08451661915, 18080.819191807914, 18516.537086572403, 18651.90674046621, 19077.236910523425, 19129.713054303917, 17461.12694365302, 18583.72124418162, 19587.412377628694, 19914.402567922985, 19971.0, 18985.810141898957, 19042.523936901132, 19304.517387064872, 19357.70963435578, 19584.0, 13397.665058373228, 13844.238566878917, 13875.72248555003, 13913.791293130409, 14167.574972750834, 14375.209363485108, 14590.416383344547, 14778.704425911637, 14864.62838429048, 15145.545633631009], "value": 9204.69278413098, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 106.0, 108.0, 109.0, 109.0, 118.0, 98.0, 109.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 134.0, 159.0, 184.0, 122.0, 154.0, 147.0, 119.0, 176.0, 116.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 175.0, 171.0, 171.0, 175.0, 164.0, 162.0, 164.0, 162.0], "value": 167.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 73.0, 168.0, 76.0, 76.0, 78.0, 88.0, 99.0, 77.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 127.0, 80.0, 87.0, 84.0, 135.0, 80.0, 81.0, 124.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 114.0, 115.0, 114.0, 114.0, 115.0, 123.0, 115.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 150.0, 148.0, 156.0, 149.0, 149.0, 149.0, 159.0, 154.0, 148.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 96.0, 95.0, 96.0, 100.0, 95.0, 95.0, 101.0, 105.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 53.0, 54.0, 54.0, 54.0, 53.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 41.0, 38.0, 38.0, 39.0, 38.0, 43.0, 45.0, 41.0], "value": 40.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 79.0, 82.0, 75.0, 74.0, 74.0, 78.0, 78.0, 86.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 117.0, 126.0, 121.0, 122.0, 127.0, 128.0, 122.0, 164.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 173.0, 177.0, 175.0, 181.0, 175.0, 176.0, 179.0, 188.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 65.0, 64.0, 65.0, 68.0, 65.0, 70.0, 66.0, 65.0], "value": 66.8, "unit": "score"}]}]} 13:11:45 INFO - Return code: 0 13:11:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:11:45 INFO - # TBPL SUCCESS # 13:11:45 INFO - Running post-action listener: _package_coverage_data 13:11:45 INFO - Running post-action listener: _resource_record_post_action 13:11:45 INFO - [mozharness: 2017-08-29 20:11:45.627385Z] Finished run-tests step (success) 13:11:45 INFO - Running post-run listener: _resource_record_post_run 13:11:45 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7081984; Write bytes: 400830464; Read time: 2788; Write time: 275092 13:11:45 INFO - TinderboxPrint: CPU usage
13.3% 13:11:45 INFO - TinderboxPrint: I/O read bytes / time
7,081,984 / 2,788 13:11:45 INFO - TinderboxPrint: I/O write bytes / time
400,830,464 / 275,092 13:11:45 INFO - TinderboxPrint: CPU idle
8,266.3 (86.7%) 13:11:45 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 13:11:45 INFO - TinderboxPrint: Swap in / out
0 / 0 13:11:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116469760; Read time: 0; Write time: 116884 13:11:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:11:45 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 7081984; Write bytes: 283947008; Read time: 2788; Write time: 158180 13:11:46 INFO - Running post-run listener: _upload_blobber_files 13:11:46 INFO - Blob upload gear active. 13:11:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:46 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 13:11:46 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'] 13:11:46 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 13:11:46 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:47 INFO - (blobuploader) - INFO - Done attempting. 13:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:48 INFO - (blobuploader) - INFO - Done attempting. 13:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:51 INFO - (blobuploader) - INFO - Done attempting. 13:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:52 INFO - (blobuploader) - INFO - Done attempting. 13:11:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:52 INFO - Return code: 0 13:11:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7055d8e8c8f049c96b0e462c3a06beffe0c1bac7c37275a14ecbe10b9939bc90c3b374e7d94e0c9515f96b588e0531b3c70ae19df458ea59a875878852c0c4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/651545a3fe452b8655e44c01652f83bf8cc6612d182a3454c0983080cc5381ed3f3d08c4c7ca8b48e41dfaf20134db6d98fd50406b26e03ad5e80923d5e67c9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9ea11ac1ab7d4367a7365a56e637fdb3f7a385bd46ddd1379ae43a47d4390a6eb8984e83114654f891c80ce634966e70bdda55d7d7b16d99c62e58e9e74857b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5391e137efb5a432d5958f55c5ba806ce1a0fbd0bb222a8efe63344394eb967c59c525ca363faffc5e7ed0b16ee11e54ae41d799fd42538478b2af5e4f51a6"} 13:11:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:52 INFO - Contents: 13:11:52 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7055d8e8c8f049c96b0e462c3a06beffe0c1bac7c37275a14ecbe10b9939bc90c3b374e7d94e0c9515f96b588e0531b3c70ae19df458ea59a875878852c0c4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/651545a3fe452b8655e44c01652f83bf8cc6612d182a3454c0983080cc5381ed3f3d08c4c7ca8b48e41dfaf20134db6d98fd50406b26e03ad5e80923d5e67c9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9ea11ac1ab7d4367a7365a56e637fdb3f7a385bd46ddd1379ae43a47d4390a6eb8984e83114654f891c80ce634966e70bdda55d7d7b16d99c62e58e9e74857b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5391e137efb5a432d5958f55c5ba806ce1a0fbd0bb222a8efe63344394eb967c59c525ca363faffc5e7ed0b16ee11e54ae41d799fd42538478b2af5e4f51a6"} 13:11:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:52 INFO - Copying logs to upload dir... 13:11:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.153287 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-29 13:11:52.956465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:52.960174) ========= 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=d2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663 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/de7055d8e8c8f049c96b0e462c3a06beffe0c1bac7c37275a14ecbe10b9939bc90c3b374e7d94e0c9515f96b588e0531b3c70ae19df458ea59a875878852c0c4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/651545a3fe452b8655e44c01652f83bf8cc6612d182a3454c0983080cc5381ed3f3d08c4c7ca8b48e41dfaf20134db6d98fd50406b26e03ad5e80923d5e67c9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9ea11ac1ab7d4367a7365a56e637fdb3f7a385bd46ddd1379ae43a47d4390a6eb8984e83114654f891c80ce634966e70bdda55d7d7b16d99c62e58e9e74857b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5391e137efb5a432d5958f55c5ba806ce1a0fbd0bb222a8efe63344394eb967c59c525ca363faffc5e7ed0b16ee11e54ae41d799fd42538478b2af5e4f51a6"} build_url:https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7055d8e8c8f049c96b0e462c3a06beffe0c1bac7c37275a14ecbe10b9939bc90c3b374e7d94e0c9515f96b588e0531b3c70ae19df458ea59a875878852c0c4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/651545a3fe452b8655e44c01652f83bf8cc6612d182a3454c0983080cc5381ed3f3d08c4c7ca8b48e41dfaf20134db6d98fd50406b26e03ad5e80923d5e67c9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9ea11ac1ab7d4367a7365a56e637fdb3f7a385bd46ddd1379ae43a47d4390a6eb8984e83114654f891c80ce634966e70bdda55d7d7b16d99c62e58e9e74857b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5391e137efb5a432d5958f55c5ba806ce1a0fbd0bb222a8efe63344394eb967c59c525ca363faffc5e7ed0b16ee11e54ae41d799fd42538478b2af5e4f51a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:52.986317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:52.986618) ========= 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=d2a8c569965ab8367867b893000001a1-1504036255.102679-1810967663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:53.070585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 13:11:53.070900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 13:11:53.071175) ========= ========= Total master_lag: 0.19 =========