builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1504036237.83 results: success (0) revision: 9957a25209908aaea4bfd4915c3201f006b29b6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:37.833785) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:37.834197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:37.834466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:37.851450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:37.851731) ========= 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=2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-29 12:50:37-- 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% 99.4M=0s 2017-08-29 12:50:37 (99.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.208879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:38.076252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:38.079596) ========= 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=2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:38.129018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-29 12:50:38.129302) ========= 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=2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-29 12:50:37,955 truncating revision to first 12 chars 2017-08-29 12:50:37,956 Setting DEBUG logging. 2017-08-29 12:50:37,956 attempt 1/10 2017-08-29 12:50:37,956 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:39,454 unpacking tar archive at: mozilla-central-9957a2520990/testing/mozharness/ program finished with exit code 0 elapsedTime=1.819049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-29 12:50:39.966113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:39.966427) ========= script_repo_revision: 9957a25209908aaea4bfd4915c3201f006b29b6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:39.969848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:39.970108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:39.981950) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-29 12:50:39.982209) ========= /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=2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:40 INFO - MultiFileLogger online at 20170829 12:50:40 in /builds/slave/test 12:50:40 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:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:40 INFO - {'append_to_log': False, 12:50:40 INFO - 'base_work_dir': '/builds/slave/test', 12:50:40 INFO - 'blob_upload_branch': 'Firefox', 12:50:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:40 INFO - 'branch': 'Firefox', 12:50:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:40 INFO - 'code_coverage': False, 12:50:40 INFO - 'config_files': ('talos/linux_config.py',), 12:50:40 INFO - 'default_actions': ('clobber', 12:50:40 INFO - 'read-buildbot-config', 12:50:40 INFO - 'download-and-extract', 12:50:40 INFO - 'populate-webroot', 12:50:40 INFO - 'create-virtualenv', 12:50:40 INFO - 'install', 12:50:40 INFO - 'setup-mitmproxy', 12:50:40 INFO - 'run-tests'), 12:50:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:40 INFO - 'disable_ccov_upload': False, 12:50:40 INFO - 'disable_stylo': False, 12:50:40 INFO - 'download_minidump_stackwalk': True, 12:50:40 INFO - 'download_symbols': 'ondemand', 12:50:40 INFO - 'enable_stylo': False, 12:50:40 INFO - 'enable_webrender': False, 12:50:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:50:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:40 INFO - 'gecko_profile': False, 12:50:40 INFO - 'gecko_profile_interval': 0, 12:50:40 INFO - 'installer_path': 'installer.exe', 12:50:40 INFO - 'log_level': 'info', 12:50:40 INFO - 'log_name': 'talos', 12:50:40 INFO - 'log_to_console': True, 12:50:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:40 INFO - 'opt_config_files': (), 12:50:40 INFO - 'pip_index': False, 12:50:40 INFO - 'suite': 'dromaeojs-e10s', 12:50:40 INFO - 'system_bits': '32', 12:50:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:40 INFO - 'title': 'talos-linux64-ix-070', 12:50:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:40 INFO - 'use_talos_json': True, 12:50:40 INFO - 'verify': 'False', 12:50:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:40 INFO - 'work_dir': 'build'} 12:50:40 INFO - [mozharness: 2017-08-29 19:50:40.022619Z] Running clobber step. 12:50:40 INFO - Running pre-action listener: _resource_record_pre_action 12:50:40 INFO - Running main action method: clobber 12:50:40 INFO - rmtree: /builds/slave/test/build 12:50:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:40 INFO - Running post-action listener: _resource_record_post_action 12:50:40 INFO - [mozharness: 2017-08-29 19:50:40.990203Z] Finished clobber step (success) 12:50:40 INFO - [mozharness: 2017-08-29 19:50:40.990298Z] Running read-buildbot-config step. 12:50:40 INFO - Running pre-action listener: _resource_record_pre_action 12:50:40 INFO - Running main action method: read_buildbot_config 12:50:40 INFO - Using buildbot properties: 12:50:40 INFO - { 12:50:40 INFO - "project": "", 12:50:40 INFO - "product": "firefox", 12:50:40 INFO - "who": "ffxbld@noreply.mozilla.org", 12:50:40 INFO - "installer_path": "public/build/target.tar.bz2", 12:50:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 12:50:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:50:40 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 12:50:40 INFO - "stage_platform": "linux64-stylo", 12:50:40 INFO - "basedir": "/builds/slave/test", 12:50:40 INFO - "buildnumber": 63, 12:50:40 INFO - "platform": "ubuntu64_hw_stylo", 12:50:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:50:40 INFO - "slavebuilddir": "test", 12:50:40 INFO - "taskId": "IKd2iCcyS5yqsSy4XFLFcg", 12:50:40 INFO - "branch": "mozilla-central", 12:50:40 INFO - "script_repo_revision": "production", 12:50:40 INFO - "revision": "9957a25209908aaea4bfd4915c3201f006b29b6e", 12:50:40 INFO - "slavename": "talos-linux64-ix-070", 12:50:40 INFO - "repo_path": "mozilla-central" 12:50:40 INFO - } 12:50:40 INFO - Finding installer, test and symbols from parent task. 12:50:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKd2iCcyS5yqsSy4XFLFcg'}, attempt #1 12:50:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IKd2iCcyS5yqsSy4XFLFcg'}, attempt #1 12:50:41 INFO - Task dependencies: I8xynoCOTwiPbft2MqBxhQ 12:50:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ'}, attempt #1 12:50:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:50:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.test_packages.json 12:50:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.crashreporter-symbols.zip 12:50:42 INFO - Running post-action listener: _resource_record_post_action 12:50:42 INFO - [mozharness: 2017-08-29 19:50:42.440184Z] Finished read-buildbot-config step (success) 12:50:42 INFO - [mozharness: 2017-08-29 19:50:42.440398Z] Running download-and-extract step. 12:50:42 INFO - Running pre-action listener: _resource_record_pre_action 12:50:42 INFO - Running main action method: download_and_extract 12:50:42 INFO - mkdir: /builds/slave/test/build/tests 12:50:42 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:50:42 INFO - trying https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.test_packages.json 12:50:42 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:50:42 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:50:43 INFO - Downloaded 989 bytes. 12:50:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:50:43 INFO - Using the following test package requirements: 12:50:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:50:43 INFO - u'common': [u'target.common.tests.zip'], 12:50:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:50:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:50:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:50:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:50:43 INFO - u'mozbase': [u'target.common.tests.zip'], 12:50:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:50:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:50:43 INFO - u'web-platform': [u'target.common.tests.zip', 12:50:43 INFO - u'target.web-platform.tests.tar.gz'], 12:50:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:50:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:50:43 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:50:43 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:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip into memory 12:50:45 INFO - Content-Length response header: 54980756 12:50:45 INFO - Bytes received: 54980756 12:50:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:50:56 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:50:56 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:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.common.tests.zip into memory 12:50:57 INFO - Content-Length response header: 54980756 12:50:57 INFO - Bytes received: 54980756 12:51:09 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:09 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:09 INFO - Fetch https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.talos.tests.zip into memory 12:51:10 INFO - Content-Length response header: 14496610 12:51:10 INFO - Bytes received: 14496610 12:51:11 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:11 INFO - trying https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:11 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:11 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:12 INFO - Downloaded 62681709 bytes. 12:51:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:12 INFO - mkdir: /builds/slave/test/properties 12:51:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:51:12 INFO - Writing to file /builds/slave/test/properties/build_url 12:51:12 INFO - Contents: 12:51:12 INFO - build_url:https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 12:51:12 INFO - Running post-action listener: _resource_record_post_action 12:51:12 INFO - Running post-action listener: find_tests_for_verification 12:51:12 INFO - Running post-action listener: set_extra_try_arguments 12:51:12 INFO - [mozharness: 2017-08-29 19:51:12.954284Z] Finished download-and-extract step (success) 12:51:12 INFO - [mozharness: 2017-08-29 19:51:12.954494Z] Running populate-webroot step. 12:51:12 INFO - Running pre-action listener: _resource_record_pre_action 12:51:12 INFO - Running main action method: populate_webroot 12:51:12 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:51:12 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:51:12 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:51:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:12 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'tests': ['damp', 'tps']}, 12:51:12 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['damp', 'tps']}, 12:51:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:51:12 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:51:12 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:51:12 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:51:12 INFO - 'other-e10s': {'tests': ['a11yr', 12:51:12 INFO - 'ts_paint', 12:51:12 INFO - 'tpaint', 12:51:12 INFO - 'sessionrestore', 12:51:12 INFO - 'sessionrestore_many_windows', 12:51:12 INFO - 'sessionrestore_no_auto_restore', 12:51:12 INFO - 'tabpaint']}, 12:51:12 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['a11yr', 12:51:12 INFO - 'ts_paint', 12:51:12 INFO - 'tpaint', 12:51:12 INFO - 'sessionrestore', 12:51:12 INFO - 'sessionrestore_many_windows', 12:51:12 INFO - 'sessionrestore_no_auto_restore', 12:51:12 INFO - 'tabpaint']}, 12:51:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:51:12 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 12:51:12 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['bloom_basic_singleton']}, 12:51:12 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['bloom_basic']}, 12:51:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:51:12 INFO - 'tsvgr_opacity', 12:51:12 INFO - 'tart', 12:51:12 INFO - 'tscrollx', 12:51:12 INFO - 'tsvg_static']}, 12:51:12 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['tsvgx', 12:51:12 INFO - 'tsvgr_opacity', 12:51:12 INFO - 'tart', 12:51:12 INFO - 'tscrollx', 12:51:12 INFO - 'tsvg_static']}, 12:51:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:51:12 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo'], 12:51:12 INFO - 'tests': ['tp5o']}, 12:51:12 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:51:12 INFO - 'talos_options': ['--mitmproxy', 12:51:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:51:12 INFO - '--firstNonBlankPaint'], 12:51:12 INFO - 'tests': ['tp6_google', 12:51:12 INFO - 'tp6_youtube', 12:51:12 INFO - 'tp6_amazon', 12:51:12 INFO - 'tp6_facebook']}, 12:51:12 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo', 12:51:12 INFO - '--mitmproxy', 12:51:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:51:12 INFO - '--firstNonBlankPaint'], 12:51:12 INFO - 'tests': ['tp6_google', 12:51:12 INFO - 'tp6_youtube', 12:51:12 INFO - 'tp6_amazon', 12:51:12 INFO - 'tp6_facebook']}, 12:51:12 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo', 12:51:12 INFO - '--stylo-threads=1', 12:51:12 INFO - '--mitmproxy', 12:51:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:51:12 INFO - '--firstNonBlankPaint'], 12:51:12 INFO - 'tests': ['tp6_google', 12:51:12 INFO - 'tp6_youtube', 12:51:12 INFO - 'tp6_amazon', 12:51:12 INFO - 'tp6_facebook']}, 12:51:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'talos_options': ['--xperf_path', 12:51:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:12 INFO - 'tests': ['tp5n']}, 12:51:12 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:51:12 INFO - 'talos_options': ['--enable-stylo', 12:51:12 INFO - '--xperf_path', 12:51:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:12 INFO - 'tests': ['tp5n']}}} 12:51:12 INFO - Running post-action listener: _resource_record_post_action 12:51:12 INFO - [mozharness: 2017-08-29 19:51:12.972454Z] Finished populate-webroot step (success) 12:51:12 INFO - [mozharness: 2017-08-29 19:51:12.972543Z] Running create-virtualenv step. 12:51:12 INFO - Running pre-action listener: _resource_record_pre_action 12:51:12 INFO - Running main action method: create_virtualenv 12:51:12 INFO - Creating virtualenv /builds/slave/test/build/venv 12:51:12 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:51:12 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:51:12 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:51:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:51:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:14 INFO - Installing pip...............done. 12:51:14 INFO - Return code: 0 12:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:51:14 INFO - Reading from file tmpfile_stdout 12:51:14 INFO - Output received: 12:51:14 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:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:51:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:14 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 12:51:14 INFO - 'HOME': '/home/cltbld', 12:51:14 INFO - 'LANG': 'en_US.UTF-8', 12:51:14 INFO - 'LANGUAGE': 'en_US:en', 12:51:14 INFO - 'LOGNAME': 'cltbld', 12:51:14 INFO - 'MAIL': '/var/mail/cltbld', 12:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:14 INFO - 'MOZ_NO_REMOTE': '1', 12:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:14 INFO - 'NO_EM_RESTART': '1', 12:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:14 INFO - 'PWD': '/builds/slave/test', 12:51:14 INFO - 'SHELL': '/bin/bash', 12:51:14 INFO - 'SHLVL': '1', 12:51:14 INFO - 'TERM': 'linux', 12:51:14 INFO - 'TMOUT': '86400', 12:51:14 INFO - 'USER': 'cltbld', 12:51:14 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:14 INFO - '_': '/tools/buildbot/bin/python'} 12:51:16 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:51:16 INFO - Downloading/unpacking pip>=1.5 12:51:16 INFO - Running setup.py egg_info for package pip 12:51:16 INFO - warning: no files found matching 'pip/cacert.pem' 12:51:16 INFO - warning: no files found matching '*.html' under directory 'docs' 12:51:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:51:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:51:16 INFO - Installing collected packages: pip 12:51:16 INFO - Found existing installation: pip 1.1 12:51:16 INFO - Uninstalling pip: 12:51:16 INFO - Successfully uninstalled pip 12:51:16 INFO - Running setup.py install for pip 12:51:16 INFO - warning: no files found matching 'pip/cacert.pem' 12:51:16 INFO - warning: no files found matching '*.html' under directory 'docs' 12:51:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:51:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:51:16 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:51:16 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:51:16 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:51:16 INFO - Successfully installed pip 12:51:16 INFO - Cleaning up... 12:51:16 INFO - Return code: 0 12:51:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:51:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:16 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 12:51:16 INFO - 'HOME': '/home/cltbld', 12:51:16 INFO - 'LANG': 'en_US.UTF-8', 12:51:16 INFO - 'LANGUAGE': 'en_US:en', 12:51:16 INFO - 'LOGNAME': 'cltbld', 12:51:16 INFO - 'MAIL': '/var/mail/cltbld', 12:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:16 INFO - 'MOZ_NO_REMOTE': '1', 12:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:16 INFO - 'NO_EM_RESTART': '1', 12:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:16 INFO - 'PWD': '/builds/slave/test', 12:51:16 INFO - 'SHELL': '/bin/bash', 12:51:16 INFO - 'SHLVL': '1', 12:51:16 INFO - 'TERM': 'linux', 12:51:16 INFO - 'TMOUT': '86400', 12:51:16 INFO - 'USER': 'cltbld', 12:51:16 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:16 INFO - '_': '/tools/buildbot/bin/python'} 12:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:16 INFO - Downloading/unpacking psutil>=3.1.1 12:51:16 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:16 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:16 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:16 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:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:17 INFO - Installing collected packages: psutil 12:51:17 INFO - Running setup.py install for psutil 12:51:17 INFO - building 'psutil._psutil_linux' extension 12:51:17 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:18 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:18 INFO - building 'psutil._psutil_posix' extension 12:51:18 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:18 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:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:19 INFO - Successfully installed psutil 12:51:19 INFO - Cleaning up... 12:51:19 INFO - Return code: 0 12:51:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:51:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:19 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 12:51:19 INFO - 'HOME': '/home/cltbld', 12:51:19 INFO - 'LANG': 'en_US.UTF-8', 12:51:19 INFO - 'LANGUAGE': 'en_US:en', 12:51:19 INFO - 'LOGNAME': 'cltbld', 12:51:19 INFO - 'MAIL': '/var/mail/cltbld', 12:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:19 INFO - 'MOZ_NO_REMOTE': '1', 12:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:19 INFO - 'NO_EM_RESTART': '1', 12:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:19 INFO - 'PWD': '/builds/slave/test', 12:51:19 INFO - 'SHELL': '/bin/bash', 12:51:19 INFO - 'SHLVL': '1', 12:51:19 INFO - 'TERM': 'linux', 12:51:19 INFO - 'TMOUT': '86400', 12:51:19 INFO - 'USER': 'cltbld', 12:51:19 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:19 INFO - '_': '/tools/buildbot/bin/python'} 12:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:51:19 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:19 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:19 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:19 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:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:51:20 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:20 INFO - Installing collected packages: mozsystemmonitor 12:51:20 INFO - Running setup.py install for mozsystemmonitor 12:51:20 INFO - Successfully installed mozsystemmonitor 12:51:20 INFO - Cleaning up... 12:51:20 INFO - Return code: 0 12:51:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:51:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:20 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 12:51:20 INFO - 'HOME': '/home/cltbld', 12:51:20 INFO - 'LANG': 'en_US.UTF-8', 12:51:20 INFO - 'LANGUAGE': 'en_US:en', 12:51:20 INFO - 'LOGNAME': 'cltbld', 12:51:20 INFO - 'MAIL': '/var/mail/cltbld', 12:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:20 INFO - 'MOZ_NO_REMOTE': '1', 12:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:20 INFO - 'NO_EM_RESTART': '1', 12:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:20 INFO - 'PWD': '/builds/slave/test', 12:51:20 INFO - 'SHELL': '/bin/bash', 12:51:20 INFO - 'SHLVL': '1', 12:51:20 INFO - 'TERM': 'linux', 12:51:20 INFO - 'TMOUT': '86400', 12:51:20 INFO - 'USER': 'cltbld', 12:51:20 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:20 INFO - '_': '/tools/buildbot/bin/python'} 12:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:20 INFO - Downloading/unpacking jsonschema==2.5.1 12:51:20 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:20 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:20 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:20 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:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:51:21 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:21 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:21 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:21 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:22 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:22 INFO - warning: no files found matching '*.txt' 12:51:22 INFO - no previously-included directories found matching 'build' 12:51:22 INFO - no previously-included directories found matching 'dist' 12:51:22 INFO - no previously-included directories found matching '.git*' 12:51:22 INFO - Installing collected packages: jsonschema, functools32 12:51:22 INFO - Running setup.py install for functools32 12:51:22 INFO - warning: no files found matching '*.txt' 12:51:22 INFO - no previously-included directories found matching 'build' 12:51:22 INFO - no previously-included directories found matching 'dist' 12:51:22 INFO - no previously-included directories found matching '.git*' 12:51:22 INFO - Successfully installed jsonschema functools32 12:51:22 INFO - Cleaning up... 12:51:22 INFO - Return code: 0 12:51:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:22 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 12:51:22 INFO - 'HOME': '/home/cltbld', 12:51:22 INFO - 'LANG': 'en_US.UTF-8', 12:51:22 INFO - 'LANGUAGE': 'en_US:en', 12:51:22 INFO - 'LOGNAME': 'cltbld', 12:51:22 INFO - 'MAIL': '/var/mail/cltbld', 12:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:22 INFO - 'MOZ_NO_REMOTE': '1', 12:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:22 INFO - 'NO_EM_RESTART': '1', 12:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:22 INFO - 'PWD': '/builds/slave/test', 12:51:22 INFO - 'SHELL': '/bin/bash', 12:51:22 INFO - 'SHLVL': '1', 12:51:22 INFO - 'TERM': 'linux', 12:51:22 INFO - 'TMOUT': '86400', 12:51:22 INFO - 'USER': 'cltbld', 12:51:22 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:22 INFO - '_': '/tools/buildbot/bin/python'} 12:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:51:22 INFO - Cleaning up... 12:51:22 INFO - Return code: 0 12:51:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:22 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 12:51:22 INFO - 'HOME': '/home/cltbld', 12:51:22 INFO - 'LANG': 'en_US.UTF-8', 12:51:22 INFO - 'LANGUAGE': 'en_US:en', 12:51:22 INFO - 'LOGNAME': 'cltbld', 12:51:22 INFO - 'MAIL': '/var/mail/cltbld', 12:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:22 INFO - 'MOZ_NO_REMOTE': '1', 12:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:22 INFO - 'NO_EM_RESTART': '1', 12:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:22 INFO - 'PWD': '/builds/slave/test', 12:51:22 INFO - 'SHELL': '/bin/bash', 12:51:22 INFO - 'SHLVL': '1', 12:51:22 INFO - 'TERM': 'linux', 12:51:22 INFO - 'TMOUT': '86400', 12:51:22 INFO - 'USER': 'cltbld', 12:51:22 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:22 INFO - '_': '/tools/buildbot/bin/python'} 12:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:51:22 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:22 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:22 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:22 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:23 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:23 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:23 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:23 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:23 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:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:51:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:24 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:24 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:24 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:24 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:24 INFO - Downloading docopt-0.6.1.tar.gz 12:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:24 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:24 INFO - Running setup.py install for blobuploader 12:51:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:51:24 INFO - Running setup.py install for requests 12:51:24 INFO - Running setup.py install for docopt 12:51:24 INFO - Successfully installed blobuploader requests docopt 12:51:24 INFO - Cleaning up... 12:51:25 INFO - Return code: 0 12:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:25 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 12:51:25 INFO - 'HOME': '/home/cltbld', 12:51:25 INFO - 'LANG': 'en_US.UTF-8', 12:51:25 INFO - 'LANGUAGE': 'en_US:en', 12:51:25 INFO - 'LOGNAME': 'cltbld', 12:51:25 INFO - 'MAIL': '/var/mail/cltbld', 12:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:25 INFO - 'MOZ_NO_REMOTE': '1', 12:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:25 INFO - 'NO_EM_RESTART': '1', 12:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:25 INFO - 'PWD': '/builds/slave/test', 12:51:25 INFO - 'SHELL': '/bin/bash', 12:51:25 INFO - 'SHLVL': '1', 12:51:25 INFO - 'TERM': 'linux', 12:51:25 INFO - 'TMOUT': '86400', 12:51:25 INFO - 'USER': 'cltbld', 12:51:25 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:25 INFO - '_': '/tools/buildbot/bin/python'} 12:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:25 INFO - Running setup.py (path:/tmp/pip-vVL9SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:25 INFO - Running setup.py (path:/tmp/pip-HM18Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:25 INFO - Running setup.py (path:/tmp/pip-6FJbvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:25 INFO - Running setup.py (path:/tmp/pip-1Djd_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:25 INFO - Running setup.py (path:/tmp/pip-kp7qdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:25 INFO - Running setup.py (path:/tmp/pip-st1TZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:25 INFO - Running setup.py (path:/tmp/pip-U0XTic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:25 INFO - Running setup.py (path:/tmp/pip-XWacW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:25 INFO - Running setup.py (path:/tmp/pip-z6Vmy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:25 INFO - Running setup.py (path:/tmp/pip-kVTWSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:25 INFO - Running setup.py (path:/tmp/pip-pnCJW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:26 INFO - Running setup.py (path:/tmp/pip-48dnSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:26 INFO - Running setup.py (path:/tmp/pip-sDz3z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:26 INFO - Running setup.py (path:/tmp/pip-g7JGLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:26 INFO - Running setup.py (path:/tmp/pip-qKTD1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:26 INFO - Running setup.py (path:/tmp/pip-rr7MRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:26 INFO - Running setup.py (path:/tmp/pip-E6EZ_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:26 INFO - Running setup.py install for manifestparser 12:51:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:26 INFO - Running setup.py install for mozcrash 12:51:26 INFO - Running setup.py install for mozdebug 12:51:26 INFO - Running setup.py install for mozdevice 12:51:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:26 INFO - Running setup.py install for mozfile 12:51:26 INFO - Running setup.py install for mozhttpd 12:51:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for mozinfo 12:51:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for mozInstall 12:51:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for mozleak 12:51:27 INFO - Running setup.py install for mozlog 12:51:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for moznetwork 12:51:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for mozprocess 12:51:27 INFO - Running setup.py install for mozprofile 12:51:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for mozrunner 12:51:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:27 INFO - Running setup.py install for mozscreenshot 12:51:27 INFO - Running setup.py install for moztest 12:51:28 INFO - Running setup.py install for mozversion 12:51:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:28 INFO - Cleaning up... 12:51:28 INFO - Return code: 0 12:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:28 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 12:51:28 INFO - 'HOME': '/home/cltbld', 12:51:28 INFO - 'LANG': 'en_US.UTF-8', 12:51:28 INFO - 'LANGUAGE': 'en_US:en', 12:51:28 INFO - 'LOGNAME': 'cltbld', 12:51:28 INFO - 'MAIL': '/var/mail/cltbld', 12:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:28 INFO - 'MOZ_NO_REMOTE': '1', 12:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:28 INFO - 'NO_EM_RESTART': '1', 12:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:28 INFO - 'PWD': '/builds/slave/test', 12:51:28 INFO - 'SHELL': '/bin/bash', 12:51:28 INFO - 'SHLVL': '1', 12:51:28 INFO - 'TERM': 'linux', 12:51:28 INFO - 'TMOUT': '86400', 12:51:28 INFO - 'USER': 'cltbld', 12:51:28 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:28 INFO - '_': '/tools/buildbot/bin/python'} 12:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:28 INFO - Running setup.py (path:/tmp/pip-1oCTsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:28 INFO - Running setup.py (path:/tmp/pip-uPBSd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:28 INFO - Running setup.py (path:/tmp/pip-oVjpUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:28 INFO - Running setup.py (path:/tmp/pip-KSKdLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:28 INFO - Running setup.py (path:/tmp/pip-cN3nKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:28 INFO - Running setup.py (path:/tmp/pip-jF81a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:28 INFO - Running setup.py (path:/tmp/pip-Ynowj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:28 INFO - Running setup.py (path:/tmp/pip-xHgjrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:28 INFO - Running setup.py (path:/tmp/pip-om2CZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:29 INFO - Running setup.py (path:/tmp/pip-4JbJrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:29 INFO - Running setup.py (path:/tmp/pip-YiZGzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:29 INFO - Running setup.py (path:/tmp/pip-Apllw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:29 INFO - Running setup.py (path:/tmp/pip-EsImQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:29 INFO - Running setup.py (path:/tmp/pip-XKs8Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:29 INFO - Running setup.py (path:/tmp/pip-OhMft_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:29 INFO - Running setup.py (path:/tmp/pip-YJluh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:29 INFO - Running setup.py (path:/tmp/pip-CIDFrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:29 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:29 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:29 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:29 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:30 INFO - Downloading blessings-1.6.tar.gz 12:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:30 INFO - Installing collected packages: blessings 12:51:30 INFO - Running setup.py install for blessings 12:51:30 INFO - Successfully installed blessings 12:51:30 INFO - Cleaning up... 12:51:30 INFO - Return code: 0 12:51:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:31 INFO - Reading from file tmpfile_stdout 12:51:31 INFO - Current package versions: 12:51:31 INFO - argparse == 1.2.1 12:51:31 INFO - blessings == 1.6 12:51:31 INFO - blobuploader == 1.2.4 12:51:31 INFO - docopt == 0.6.1 12:51:31 INFO - functools32 == 3.2.3-2 12:51:31 INFO - jsonschema == 2.5.1 12:51:31 INFO - manifestparser == 1.1 12:51:31 INFO - mozInstall == 1.13 12:51:31 INFO - mozcrash == 1.0 12:51:31 INFO - mozdebug == 0.1 12:51:31 INFO - mozdevice == 0.51 12:51:31 INFO - mozfile == 1.2 12:51:31 INFO - mozhttpd == 0.7 12:51:31 INFO - mozinfo == 0.10 12:51:31 INFO - mozleak == 0.1 12:51:31 INFO - mozlog == 3.5 12:51:31 INFO - moznetwork == 0.27 12:51:31 INFO - mozprocess == 0.25 12:51:31 INFO - mozprofile == 0.28 12:51:31 INFO - mozrunner == 6.13 12:51:31 INFO - mozscreenshot == 0.1 12:51:31 INFO - mozsystemmonitor == 0.3 12:51:31 INFO - moztest == 0.8 12:51:31 INFO - mozversion == 1.4 12:51:31 INFO - psutil == 3.1.1 12:51:31 INFO - requests == 1.2.3 12:51:31 INFO - wsgiref == 0.1.2 12:51:31 INFO - Installing None 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', '-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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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', '-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:31 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: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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:31 INFO - '_': '/tools/buildbot/bin/python'} 12:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:51:31 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:31 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:31 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:31 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 - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:51:32 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:32 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:32 INFO - Installing collected packages: simplejson 12:51:32 INFO - Running setup.py install for simplejson 12:51:32 INFO - building 'simplejson._speedups' extension 12:51:32 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:33 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:33 INFO - Successfully installed simplejson 12:51:33 INFO - Cleaning up... 12:51:33 INFO - Return code: 0 12:51:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:33 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 0x28501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbfb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, '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': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 12:51:33 INFO - 'HOME': '/home/cltbld', 12:51:33 INFO - 'LANG': 'en_US.UTF-8', 12:51:33 INFO - 'LANGUAGE': 'en_US:en', 12:51:33 INFO - 'LOGNAME': 'cltbld', 12:51:33 INFO - 'MAIL': '/var/mail/cltbld', 12:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:33 INFO - 'MOZ_NO_REMOTE': '1', 12:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:33 INFO - 'NO_EM_RESTART': '1', 12:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:33 INFO - 'PWD': '/builds/slave/test', 12:51:33 INFO - 'SHELL': '/bin/bash', 12:51:33 INFO - 'SHLVL': '1', 12:51:33 INFO - 'TERM': 'linux', 12:51:33 INFO - 'TMOUT': '86400', 12:51:33 INFO - 'USER': 'cltbld', 12:51:33 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:33 INFO - '_': '/tools/buildbot/bin/python'} 12:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:51:33 INFO - Cleaning up... 12:51:33 INFO - Return code: 0 12:51:33 INFO - Running post-action listener: _resource_record_post_action 12:51:33 INFO - Running post-action listener: _start_resource_monitoring 12:51:33 INFO - Starting resource monitoring. 12:51:33 INFO - [mozharness: 2017-08-29 19:51:33.941062Z] Finished create-virtualenv step (success) 12:51:33 INFO - [mozharness: 2017-08-29 19:51:33.942061Z] Running install step. 12:51:33 INFO - Running pre-action listener: _resource_record_pre_action 12:51:33 INFO - Running main action method: install 12:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:34 INFO - Reading from file tmpfile_stdout 12:51:34 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:34 INFO - Reading from file tmpfile_stdout 12:51:34 INFO - Output received: 12:51:34 INFO - Usage: mozinstall [options] installer 12:51:34 INFO - Options: 12:51:34 INFO - -h, --help show this help message and exit 12:51:34 INFO - -d DEST, --destination=DEST 12:51:34 INFO - Directory to install application into. [default: 12:51:34 INFO - "/builds/slave/test"] 12:51:34 INFO - --app=APP Application being installed. [default: firefox] 12:51:34 INFO - mkdir: /builds/slave/test/build/application 12:51:34 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:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:51:50 INFO - Reading from file tmpfile_stdout 12:51:50 INFO - Output received: 12:51:50 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:50 INFO - Running post-action listener: _resource_record_post_action 12:51:50 INFO - [mozharness: 2017-08-29 19:51:50.733275Z] Finished install step (success) 12:51:50 INFO - [mozharness: 2017-08-29 19:51:50.733549Z] Running setup-mitmproxy step. 12:51:50 INFO - Running pre-action listener: _resource_record_pre_action 12:51:50 INFO - Running main action method: setup_mitmproxy 12:51:50 INFO - Skipping: mitmproxy is not required 12:51:50 INFO - Running post-action listener: _resource_record_post_action 12:51:50 INFO - [mozharness: 2017-08-29 19:51:50.734655Z] Finished setup-mitmproxy step (success) 12:51:50 INFO - [mozharness: 2017-08-29 19:51:50.734871Z] Running run-tests step. 12:51:50 INFO - Running pre-action listener: _resource_record_pre_action 12:51:50 INFO - Running pre-action listener: _set_gcov_prefix 12:51:50 INFO - Running main action method: run_tests 12:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:50 INFO - Python 2.7.3 12:51:50 INFO - Return code: 0 12:51:50 INFO - grabbing minidump binary from tooltool 12:51:50 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:50 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 0x2bbc580>, '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 0x2bbd480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:50 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:51:50 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:51:50 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:51:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:50 INFO - Return code: 0 12:51:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:50 INFO - ENV: RUST_BACKTRACE is now full 12:51:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:50 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-070', '--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:51:50 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-070 --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:51:50 INFO - Using env: {'DISPLAY': ':0', 12:51:50 INFO - 'HOME': '/home/cltbld', 12:51:50 INFO - 'LANG': 'en_US.UTF-8', 12:51:50 INFO - 'LANGUAGE': 'en_US:en', 12:51:50 INFO - 'LOGNAME': 'cltbld', 12:51:50 INFO - 'MAIL': '/var/mail/cltbld', 12:51:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:50 INFO - 'MOZ_NO_REMOTE': '1', 12:51:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:50 INFO - 'NO_EM_RESTART': '1', 12:51:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:50 INFO - 'PWD': '/builds/slave/test', 12:51:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:50 INFO - 'RUST_BACKTRACE': 'full', 12:51:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:50 INFO - 'SHELL': '/bin/bash', 12:51:50 INFO - 'SHLVL': '1', 12:51:50 INFO - 'STYLO_FORCE_ENABLED': '1', 12:51:50 INFO - 'TERM': 'linux', 12:51:50 INFO - 'TMOUT': '86400', 12:51:50 INFO - 'USER': 'cltbld', 12:51:50 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:50 INFO - '_': '/tools/buildbot/bin/python'} 12:51:50 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-070', '--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:51:51 INFO - mozversion application_buildid: 20170829190058 12:51:51 INFO - mozversion application_changeset: 9957a25209908aaea4bfd4915c3201f006b29b6e 12:51:51 INFO - mozversion application_display_name: Nightly 12:51:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:51 INFO - mozversion application_name: Firefox 12:51:51 INFO - mozversion application_remotingname: firefox 12:51:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:51:51 INFO - mozversion application_vendor: Mozilla 12:51:51 INFO - mozversion application_version: 57.0a1 12:51:51 INFO - mozversion platform_buildid: 20170829190058 12:51:51 INFO - mozversion platform_changeset: 9957a25209908aaea4bfd4915c3201f006b29b6e 12:51:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:51:51 INFO - mozversion platform_version: 57.0a1 12:51:51 INFO - using testdate: 1504036311 12:51:51 INFO - actual date: 1504036311 12:51:51 INFO - starting webserver on 'localhost:60565' 12:51:51 INFO - SUITE-START | Running 2 tests 12:51:51 INFO - TEST-START | dromaeo_css 12:51:51 INFO - Initialising browser for dromaeo_css test... 12:51:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60565/getInfo.html -profile /tmp/tmpEmIVfi/profile 12:51:51 INFO - TEST-INFO | started process 3460 (/builds/slave/test/build/application/firefox/firefox http://localhost:60565/getInfo.html) 12:51:59 INFO - TEST-INFO | 3460: exit 0 12:51:59 INFO - Browser initialized. 12:51:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:59 INFO - Using env: {'DISPLAY': ':0', 12:51:59 INFO - 'HOME': '/home/cltbld', 12:51:59 INFO - 'JSGC_DISABLE_POISONING': '1', 12:51:59 INFO - 'LANG': 'en_US.UTF-8', 12:51:59 INFO - 'LANGUAGE': 'en_US:en', 12:51:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:51:59 INFO - 'LOGNAME': 'cltbld', 12:51:59 INFO - 'MAIL': '/var/mail/cltbld', 12:51:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:59 INFO - 'MOZ_CRASHREPORTER': '1', 12:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:51:59 INFO - 'MOZ_NO_REMOTE': '1', 12:51:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:59 INFO - 'NO_EM_RESTART': '1', 12:51:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:59 INFO - 'PWD': '/builds/slave/test', 12:51:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:59 INFO - 'RUST_BACKTRACE': 'full', 12:51:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:59 INFO - 'SHELL': '/bin/bash', 12:51:59 INFO - 'SHLVL': '1', 12:51:59 INFO - 'STYLO_FORCE_ENABLED': '1', 12:51:59 INFO - 'TERM': 'linux', 12:51:59 INFO - 'TMOUT': '86400', 12:51:59 INFO - 'USER': 'cltbld', 12:51:59 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 12:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:59 INFO - '_': '/tools/buildbot/bin/python'} 12:51:59 INFO - TEST-INFO | started process 3659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEmIVfi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:00 INFO - PID 3659 | 12:52:00 INFO - PID 3659 | (/builds/slave/test/build/application/firefox/firefox:3711): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:52:00 INFO - PID 3659 | 12:52:11 INFO - PID 3659 | RSS: Main: 167378944 12:52:11 INFO - PID 3659 | 12:55:09 INFO - PID 3659 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60565/tests/dromaeo/cssquery-ext.html) 12:55:11 INFO - PID 3659 | RSS: Main: 173162496 12:55:11 INFO - PID 3659 | 12:58:13 INFO - PID 3659 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-ext.html (next: http://localhost:60565/tests/dromaeo/cssquery-jquery.html) 12:58:13 INFO - PID 3659 | RSS: Main: 170627072 12:58:13 INFO - PID 3659 | 13:01:15 INFO - PID 3659 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60565/tests/dromaeo/cssquery-mootools.html) 13:01:15 INFO - PID 3659 | RSS: Main: 172388352 13:01:15 INFO - PID 3659 | 13:04:17 INFO - PID 3659 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60565/tests/dromaeo/cssquery-prototype.html) 13:04:18 INFO - PID 3659 | RSS: Main: 171520000 13:04:18 INFO - PID 3659 | 13:07:22 INFO - PID 3659 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60565/tests/dromaeo/cssquery-yui.html) 13:07:22 INFO - PID 3659 | RSS: Main: 172294144 13:07:22 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-yui.html (next: http://localhost:60565/tests/dromaeo/cssquery-dojo.html) 13:10:24 INFO - PID 3659 | RSS: Main: 175030272 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | __start_tp_report 13:10:24 INFO - PID 3659 | _x_x_mozilla_page_load 13:10:24 INFO - PID 3659 | _x_x_mozilla_page_load_details 13:10:24 INFO - PID 3659 | |i|pagename|runs| 13:10:24 INFO - PID 3659 | |0;dojo.html;3313.7514686398513;3315.8839440619577;3325.8170800605963;3347.564816573845;3352.4468462703653;6276;6356.2054743157105;6357.872842543146;6382;6383.138276332694;6151.4463698267145;6274.152989346437;6282.591631543946;6289.622622642644;6291.528135389853;5758.856028599276;5762.6254293471;5778.162166485857;5796.30444346679;5799.884002319951;5790.160426738121;5803.622764520293;5829.329627092875;5839.9124013139835;5900.380460051697;5898.970505147468;5915.378885217055;5937.85155371117;5939.109133629969;5943.138244954501;5835.066389377679;5847.104047421307;5860.120981852713;5897.734601942923;5909.4090590941;5090.796368145269;5541.390447050821;5669.348024977139;5674.631148975303;5823.88352232953;6327.588706734047;6328.208973878265;6404.1674582304;6417.518686098561;6421.325760795143;6736.730530778763;6788.8302792430095;6789.932100679029;6851.9657401712675;6889.586624802478;6904.896426553606;6905.240423553405;6946.444284457231;6949;6949.5135340526185;6390.456811171056;6422.775202867924;6424.229092508882;6428.357164283628;6431.807045788587;7011.579305241702;7023.473239507058;7024.192217894905;7126.394256488153;7128.322809333105;6495.967520162463;6596.86806263872;6611.636360000246;6682.665866706742;6801.693923773442;6606.992533261582;6684.398404143651;6694.129763130762;6695.665216739144;6787.660616969132;6726.3946244837225;6752.459803215731;6755.392014718601;6827.829304267433;6837.931620683829;6771.322867713189;6778.93221067783;6882.621455819878;6889.311068893171;6890.965545172242;5310.070737620901;5316.494932981361;5378.51593356592;5391.110466773017;5400.21696853954;4576.039031803292;4660.743659098782;4675.6727029108315;4679.555442232982;4705.858824235278;6027.7287522061615;6035.275766907999;6037.335893051761;6051.273847138372;6053.788117415869;6797.694103765342;6809.421199198025;6911.205211400653;6912.997615345746;6918.481113916477;5946.345901950782;5966.552508561876;6040.214772079602;6044.274687037584;6048.909266361008;5685.772569097273;5782.2483077199695;5838.182654428383;5889.852753681106;5910.52715782745;6561.0814485972005;6570.047343135218;6573.769918052845;6579.47364210862;6652.234992975773;6867.3476019778045;6872.759453419107;6936.861262774615;6956.826079348057;6971.198312193959;6546.149000629887;6551.6069035858;6561.967190164019;6666;6679.632620205741;6632.204135503771;6650.767223147167;6651.767188148391;6667.633280169637;6668.499862510428;6867.553609015398;6903.930960690329;6962.234154242928;6968.442524597918;6969.372756451944;6613.834654133685;6633.900491492728;6638.302978187221;6720.630365329954;6730.629815360006;6424.710888009958;6533.509986750918;6604.405603495708;6610;6725.461963042847;6536.215654121535;6553.5084868635995;6558.573692709959;6558.606483610999;6562.212534495891;6516.152900122954;6517.478601711947;6662.866742665216;6698.66506674674;6757.560758550679;6430.678466076771;6498.252700939453;6515.837104072436;6528.67356632176;6534.869302613826 13:10:24 INFO - PID 3659 | |1;ext.html;829.6432534010377;876.8071024374638;906.5965645287849;913.5797533134757;1139.5043156227048;30135.095947121594;30817.537736933962;39834;40882.38676419856;40915.59084409155;41005;41386.58613413865;41474.792626036906;41489;41527.792361038155;7667.463277570572;7754.340881025106;7876.094249161334;7901.48640338379;7903.565303908283;7730.884036739425;7836.568988705619;7841.137474877787;7842.137364889858;7848.803779905519;7821.765347039598;7867.606619669023;7871.370290376756;7880.80297992549;7888.684452621888;7821.452498325119;7841.803954901116;7843.254890785395;7848.6860525579195;7854.214578542157;7664.65509052094;7690.653920573532;7698;7703.1526532081425;7708;36942;37094.25811483782;37122.443163352575;37142;37227.62772372269;3568.750187486877;3575.302815950891;3580.6419358064245;3600.6759391654878;3605.56733192016;30588.8470557648;30838.38323233545;30882.845585772153;30907.227319317197;30910.690893091007;5175.560077393426;5195.610329225286;5226.817061402832;5243.056249875021;5247.449017853109;181603;182485;183141.99999999866;183422;183966;46009.539904600526;46014;46274.30588541175;46281.07437851224;46356.3046554302;48275;48318.516814831404;48470;48601.75699121482;48612.27081593779;15661.843381566267;15893.682126357407;16006.839931600534;16078.115703636413;16092.758608620647;11833;12010.15928884987;13107.868921310856;13229.801552976713;13276.070675052653;13700.177989320673;13766.380512876945;13780.379882905294;13791.862081379259;13930.791038134435;5845;5913.852153696106;5915.349311575723;5945.791897283574;5967.5524335675;1016.2479764973866;1032.1639472027682;1035.8653375061194;1040.095117247984;1043.9634612788668;22562.32313030612;22694.432639183822;22935.587745620785;22972.88513557455;23077;1129.3054771315747;1135.914806389524;1137.4256000719583;1138.1009002887793;1146.8107762219308;12060.939695301468;12111.576094836639;12135.393230338448;12140.635780926586;12174.756504869853;216780;217926;218372;218408;219071;49648.50351496511;50193.74903125534;50208.497915021115;50219;50382.49617503778;1430.3634882477197;1483.5994281543922;1486.1751727790963;1490.4038384646228;1506.7513860213162;21972.450688732908;22259.77740222577;22510.662340064584;22575.66136507921;22741.09035638556;36449.817750911076;36451.81774091112;36498.452523212705;36501.81749091238;36557.45163822491;191642;192574;192650;193265;193352;33284.500732488545;33500.66499335073;33870;35334.29331413409;35520;42357.788211058745;44127.11745765131;44191;44224.55775442333;44398.55807930595;32598;32697.34605307928;32724.83637581797;32932.67067329392;33043.173920652174;32622.83688581542;32739.34521309608;32822.34355312928;32937.341253175284;33055.173620658716;36061.45907811332;36245;36343.63656363403;36395.09012274714;36445.27109457849;31807.04578862638;31888.521672174473;32052.35895282035;32090.35819283648;32257.51613725749;23939.76060239375;24119.276421707378;24217;24627.630585540872;24652.38369040788 13:10:24 INFO - PID 3659 | |2;jquery.html;554.6616563896024;565.524959034411;571.7770069672825;577.3331801768957;577.5552824325272;21657.458563535918;22320.441988950242;22502.3249302521;22559.210427635036;22580.66129008066;25595.61606575903;26135.47729045418;26344.0779572715;26352;26420.471590568177;6585.078089067534;6735.629540375277;6736.29268926763;6740.191177058759;6745.021971814084;4841.394825646794;6125.479334256594;6732.2257940336995;6781.084553585277;6786.423154031913;4065.7357271777387;4069.7965101744944;4073.63337299643;6735.629540375277;6750.088738020353;6718.49611279156;6727.024581435664;6754.898676519856;6755.898661520081;6772;6202.720877560476;6220.720067596969;6240.812775616739;6242.563020588561;6261.906071408933;28103.85948070267;30025.699743002726;30644.69355306463;30647.693523064707;30668.8466557668;2067.8966051697507;2101.6952541881496;2104.2004038465284;2104.778998205182;2106.926257580977;19617.705734413994;20064;20108.195672173097;20120.698189527167;20192;2375.2082115183493;2399.196269249803;2456.0421435640114;2470.4441500662388;2471.209213051824;131512;133557.99999999904;134039;134529;136017;14283.357248923823;14628.414863405558;14694.853051469563;14735.263236838115;14903.403863845542;22450.214242501435;22463.32610021702;22616.0953561859;22716.09135634556;22835;10024.19806415485;10185.148158515627;10287.331323463952;10288.897111028793;10354.17166626668;8411.317736452735;9478.336516443782;9588.280878934107;9711.174550163174;9728.854067188999;7934.801629959297;8844.248238899638;8939.329550283755;9079.092090790868;9101.95449022764;2622.632831403605;2628.6319915211884;2660.86695665216;2665.65346504957;2769.2661444717164;966.3766870368573;976.9023097690174;986.2898712926682;1002.0230275481493;1007.3754272351042;19271.421857344303;19454;19688.357653834086;19818.108185131703;19870.60258794816;1051.9105876000472;1053.3890343600692;1056.3028401255135;1059.1526778577108;1065.0414626835754;10646.840297395545;10911.672649820519;10931.56273749057;10960.232783705063;11048.723781905355;489234;500377;500994;503681;505473;107097.46451267693;108650.45674771575;109610;110446.44776776065;112812;1158.4381574936149;1181.9468123934444;1190.2560899438024;1197.9041676665845;1198.6823491774687;16670.24983875704;17240.741388878927;17242.913785430992;17469.563260918578;17626.383076592258;53304;54009.45990540044;54086.18870717021;54713.72643136759;54942;65716.34283657293;65986;67336.6633166831;67342;68382.65808670924;12054.457549410123;12637.494500219887;14113.858861411665;14500.34748436344;20427.4893127673;23799;24232;24435.26694199177;24473.38816529601;24501.632475512524;17929.82070179334;18654.53363665919;19351.4194574163;19449.124789384794;19455.90272048631;16197.352105915632;17197.914010429868;17247.137643118043;17361.56596085108;17375.04437255963;19370.322038728576;19397.4180774577;19474.415767526996;19662.80337196667;19724.40826775199;20330.390088297376;20379;20423.489412764204;20556.28053018137;20559.486012849797;16592.66814663676;18582.535436614195;18594.163262652943;18686.252549898396;18764.718529222344 13:10:24 INFO - PID 3659 | |3;mootools.html;1321.3789518926103;1394.8744612984829;1395.3372148229591;1395.902286839921;1396.2390497179038;14409.495667651621;14502.854971450282;15113.697726045486;15154.696906061887;15169.014014089076;15105.773413398807;15321.080735155898;15359;15369.308381122848;15402.768958465633;2651.4829608226355;2721.8366897986084;2723.700392956773;2727.7954153438473;2728.6998430172666;2686.717894621066;2777.5139350613663;2778.152663437661;2778.2220978126156;2778.9856702303714;2648.880800363979;2680.6113113598517;2681.4368982513697;2682.235562864584;2683.476722039203;2590.3265151060764;2597.1559243245924;2663.5205662980657;2663.613776002488;2666.440047589999;2636.907708230222;2675.9464810703676;2695.663042119735;2698.352395425084;2702.63514425552;13825.930870345584;13977.301134943213;14000.92999535006;14008.29958502081;14375;7601.0878694557005;7869.291763741234;7869.331106855924;7891.644875980594;7898.170692077364;5185.818496352609;5205.27126202332;5285.550728188108;5317.175837745156;5392.56859451243;1904.228787341129;1924.5765931495048;1924.9326273580357;1949.6588097083095;1964.489232799468;24172.39569010771;24411.755882441303;24545.386365341008;24546.386340341454;24557.754422455724;6839.555428897205;7286.125664920138;7310.378617817439;7557.395408367427;7583;16417.83582164187;16556.75164872528;16568.337266509203;16573.50279491617;16591.170441477876;7758.9612051939375;7938.761837144895;7959.562224077616;7966.681332746625;7966.920330796734;6001.399860014051;6251.187345645037;6431.5819471734185;7328.047353843966;7435.925640743631;5234.816781412632;5342.465753424626;5419.214213938957;5422.891542169214;5486.177073439016;1549.8527639874194;1582.5568840724616;1592.816826064994;1610.9516714498584;1617.215650409574;845.7420486751599;862.9611667474978;880.9735707928772;884.6063501741792;893.0756666849779;7215.639218039182;7304.488685791944;7312.451566132561;7337.156227033853;7362.595057271901;710.1691021504852;715.7852644206821;718.8023293594304;719.4460265595567;730.7186733107792;4612.123696497655;4916.901661966741;5499.230107784913;5526.253955715927;5608;19591.216351345785;19890.50273743168;20804.89597552033;20845.478863028544;20847.583048338947;20148.597028059357;20618.381448556567;20713.79286207149;20715.482112946996;20795.68806467904;10272.33229840043;10709.839352409721;10746.946265268623;10964.780704385868;10974.945125274322;8486.957565212135;8719.956400217958;8929.776755581162;8948.328875334506;9094.454332740057;17831.910840446235;18089.005104719366;18222.908885455487;18333.449996500127;18688.906555467136;17958.461246162635;18456.446306610822;18473.07634618237;18682.532936676693;18771.34300299483;11060.391678457761;11390.145739069769;11393.829092563452;11418.600348987746;11428;13277.933610331887;13382.263975481443;13549.661258468617;13563.728725425633;13660.65848353799;10863.185261105607;10885.836712449161;11069.391183484986;11098.334099954029;11217.102631789601;10732.034116929513;10977.725556860823;11158.218924675195;11159.553617855196;11162.274452160584;9293.395929264576;9456.574454149717;9482.288828337765;9484.288678349014;9492.620295188115;6955.686994085379;7073.151221853411;7091.964540177266;7128;7221.963890180726;7065.717371305091;7149.356557909813;7159;7195.784126476214;7209.567425954459 13:10:24 INFO - PID 3659 | |4;prototype.html;490.9127358605885;496.14273345461277;519.3015394294672;520.1599416941639;521.4003895520151;6320.873582528352;6431.292557818636;6442.903356449657;6482.6434546099945;6559.73761049558;6103.7253323600435;6284.780032698856;6291.213598300213;6323.249386516868;6361.872762544746;5092.618053645972;5112.182050871861;5135.922961155586;5137.332146820927;5137.816428018105;5046.495350464961;5061;5074.695518268897;5076.898462030757;5118.257852611369;4905.558499735023;5037.697738135706;5045.672031317971;5058.317127187837;5073.264376665381;5033.169527028036;5048.974755126219;5052.949470505285;5080.1617733074;5081.314022606938;4485.775711214459;4533.184026875161;4559.817607295704;4571.988325136929;4587.128445595359;6194.783182588588;6215.347388524185;6239.65681887496;6242.781502647431;6258.1551490548645;5765.1928729977835;5802.535797136261;5808.099744539603;5814.883702325972;5820.854478638025;6582.893474088293;6653;6658.201015878126;6690.197176338822;6726.495512836508;4900.431861804224;4917.50824917509;4927.77824997876;4951.356323677899;4957.950420495785;6930.257660863128;7003.299670033007;7080.752173673896;7089.574625522485;7114.466415018895;4979.975100124549;5023.623228257895;5083.872903177376;5091.421659285634;5117.155669314521;5130.179171332569;5160.948390516121;5164.302819119446;5184.611154163453;5194;5776.5089967352405;5814.360420353758;5822.941770582324;5823.184754134425;5827.562932780059;6585.506087043395;6647.138801135689;6682.699278532477;6764.4926630502905;6766.650507998572;1663.193351224655;1697.896367361225;1720.8365205305477;1727.870409719251;1746.589551455407;1165.9417029148508;1220.6582156996055;1227.3188380448937;1242.577523641966;1246.0903540415547;5824.271966004249;5866.354700982888;5943.791967281124;5951.285845698544;5966.940330596725;6549.312322206195;6693.163354580677;6732.417881797774;6807.625580593115;6825.317468253234;5872.120921305227;5898.2867880774465;5919.733611987471;5950.404959504015;5958.493528050164;3542.929141417209;3553.9644603553634;3575.5173051637694;3604.585472670624;3629.891103266906;6455.61266324022;6466.773662921775;6506.837329066811;6574.257821677259;6601.240857301375;6902.585844849325;6932.272111428228;6951.2353641099435;7029.4376449883885;7076.551055687092;6518.57629254097;6534.4445722113205;6626;6638.966805165944;6645.734170633121;6793.331600935439;6853.657317134223;6882.311768823078;6896.344847239504;6900.896486552806;6740.359665831738;6761.188657361148;6799.2520822708475;6864.4165245954655;6872.587644741331;6590.275069742421;6595.318193860535;6668.433183179484;6672.232693240339;6706.966465167643;5055.443901170942;5066.721330326867;5073.746312684425;5076.238564215398;5105.770240339268;6922.203946546211;6939.4448444125355;6976.058232138596;7005.509614326948;7026.718931242897;6620.2386725527185;6641.634710090798;6645;6671.099401580725;6733.360330768569;6420.1974753155855;6635.23694775107;6664.933350666625;6665.633390163393;6680.866382672222;6244.968775156095;6547.312532184052;6563.507736919654;6577.3422657735755;6644.4020038196795;6703.966480167568;6743.460523158234;6743.8303997121275;6759.493038022267;6771.255161932085;6319.178506794087;6453.741850325934;6467.353264673495;6475.449586785176;6499.2200935887995 13:10:24 INFO - PID 3659 | |5;yui.html;881.193707757402;888.8222355528892;902.3142411767055;903.2006674093425;905.2893478619283;17912.82087179128;18474.261029558835;18501.907490462563;18513.537161570934;18611.534711632197;19049.2380304788;20061;21758.782412175875;21998.45003874904;22114.88942555289;977.0376179463223;998.7103739915416;1003.4731765822928;1003.5935446144323;1004.4826914139225;906.755176102452;998.2612866478789;1008.5461542305954;1008.6620981971048;1011.0142610954298;1069.4866464097238;1070.764431825001;1071.796358691846;1071.8767341755681;1072.2762135558505;1064.2443864855923;1066.8293073108305;1067.0290036067142;1067.3542506783363;1068.2148620763694;781.2968328504335;781.4256521456725;781.4646966827742;783.2246076384339;783.3106865957977;19626.41120766365;19903.90048049765;19922;19939.700904486443;20417.4895627609;21149.15403383863;21345.146194152214;21479.24822631216;21636.675449868264;21651.891740541196;15586.844131558653;15683.529494115195;15941.760873586905;16132.516024519166;16522.83477165225;3777.2823163598828;3803.1442925341853;3813.161104556993;3815.2178803345246;3817.751846129993;114265;115589.4220528892;115603.42198289039;117023.41488292589;118802;16511.504654860375;16989.49031529056;17018.064006479763;17074.914625426794;17095.572610684583;30189.698103019127;30963.69036309608;31179.06462806074;31362.843185783924;31434.68565314363;8591;8969;9014.098590140933;9016.819663606822;9030.413023153475;4127.545969943304;4370.825166993348;4453.421055262795;4462.732236065782;4464.709793863389;5172.353455818023;5297.708626025606;5308.734563271821;5325.988062268157;5327.680339179662;1060.2260349944584;1089.8801131875487;1102.862142232221;1104.6354702948008;1105.3975583307117;670.4535803320279;683.6274230544366;687.285223367702;697.9739782519688;712.0316369737153;11636.534538618529;11999.700007499883;12095.334756588296;12372.62882113538;13076.346182690828;657.8519833037528;692.8441100752391;696.5994553131969;700.6181631011111;707.398711095575;5850.64896106235;6143.662098584531;6146.7233974471255;6597.637129957899;6667.266600673922;103398;108611.45694271478;109471.45264273627;111573;111792;94034.52982735043;94767.52616237012;95378.52310738541;96967.51516242514;99079;84160;86292.56853715691;86398.13601864026;86720;87236;12798.360081996048;12935;12985.740285194432;13078;13132.803007954697;36700.81649591735;37859.81070094632;38134.2373152541;38434.2313153741;39889;50014;50730.2390464136;50937.23594146017;51168.74415627898;52081.47918520766;18455.354062607745;18679.346222882134;18878.3392581259;18921.716174257122;18954.147063382457;20935.685964710847;21155.048022839317;21186.470338241666;21200.257990970244;21204.893975530642;17375.56561085983;17429.912850435667;17514.912425437793;17550.561235969202;17691.911540442215;16921.492355229362;18810.905945470186;19171.904140479208;19666.90166549158;19886.801131988494;18655.253789848255;18919.621607568046;19041.904790475957;19154.71267930954;19470.318538851072;13431.865681343452;13761.655958601115;13990.510332138327;14345.497907573184;14953.55139345778;14733.852661473677;14936.103833769574;14936.551903442914;15317.770233446285;15436.382544698086 13:10:24 INFO - PID 3659 | __end_tp_report 13:10:24 INFO - PID 3659 | __start_cc_report 13:10:24 INFO - PID 3659 | _x_x_mozilla_cycle_collect,360 13:10:24 INFO - PID 3659 | __end_cc_report 13:10:24 INFO - PID 3659 | __startTimestamp1504037424750__endTimestamp 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | ------- Summary: start ------- 13:10:24 INFO - PID 3659 | Number of tests: 6 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | [#0] dojo.html Cycles:165 Average:6268.45 Median:6528.67 stddev:743.73 (11.4%) stddev-sans-first:708.98 13:10:24 INFO - PID 3659 | Values: 3313.8 3315.9 3325.8 3347.6 3352.4 6276.0 6356.2 6357.9 6382.0 6383.1 6151.4 6274.2 6282.6 6289.6 6291.5 5758.9 5762.6 5778.2 5796.3 5799.9 5790.2 5803.6 5829.3 5839.9 5900.4 5899.0 5915.4 5937.9 5939.1 5943.1 5835.1 5847.1 5860.1 5897.7 5909.4 5090.8 5541.4 5669.3 5674.6 5823.9 6327.6 6328.2 6404.2 6417.5 6421.3 6736.7 6788.8 6789.9 6852.0 6889.6 6904.9 6905.2 6946.4 6949.0 6949.5 6390.5 6422.8 6424.2 6428.4 6431.8 7011.6 7023.5 7024.2 7126.4 7128.3 6496.0 6596.9 6611.6 6682.7 6801.7 6607.0 6684.4 6694.1 6695.7 6787.7 6726.4 6752.5 6755.4 6827.8 6837.9 6771.3 6778.9 6882.6 6889.3 6891.0 5310.1 5316.5 5378.5 5391.1 5400.2 4576.0 4660.7 4675.7 4679.6 4705.9 6027.7 6035.3 6037.3 6051.3 6053.8 6797.7 6809.4 6911.2 6913.0 6918.5 5946.3 5966.6 6040.2 6044.3 6048.9 5685.8 5782.2 5838.2 5889.9 5910.5 6561.1 6570.0 6573.8 6579.5 6652.2 6867.3 6872.8 6936.9 6956.8 6971.2 6546.1 6551.6 6562.0 6666.0 6679.6 6632.2 6650.8 6651.8 6667.6 6668.5 6867.6 6903.9 6962.2 6968.4 6969.4 6613.8 6633.9 6638.3 6720.6 6730.6 6424.7 6533.5 6604.4 6610.0 6725.5 6536.2 6553.5 6558.6 6558.6 6562.2 6516.2 6517.5 6662.9 6698.7 6757.6 6430.7 6498.3 6515.8 6528.7 6534.9 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | [#1] ext.html Cycles:180 Average:36539.16 Median:34602.15 stddev:51290.35 (148.2%) stddev-sans-first:51364.14 13:10:24 INFO - PID 3659 | Values: 829.6 876.8 906.6 913.6 1139.5 30135.1 30817.5 39834.0 40882.4 40915.6 41005.0 41386.6 41474.8 41489.0 41527.8 7667.5 7754.3 7876.1 7901.5 7903.6 7730.9 7836.6 7841.1 7842.1 7848.8 7821.8 7867.6 7871.4 7880.8 7888.7 7821.5 7841.8 7843.3 7848.7 7854.2 7664.7 7690.7 7698.0 7703.2 7708.0 36942.0 37094.3 37122.4 37142.0 37227.6 3568.8 3575.3 3580.6 3600.7 3605.6 30588.8 30838.4 30882.8 30907.2 30910.7 5175.6 5195.6 5226.8 5243.1 5247.4 181603.0 182485.0 183142.0 183422.0 183966.0 46009.5 46014.0 46274.3 46281.1 46356.3 48275.0 48318.5 48470.0 48601.8 48612.3 15661.8 15893.7 16006.8 16078.1 16092.8 11833.0 12010.2 13107.9 13229.8 13276.1 13700.2 13766.4 13780.4 13791.9 13930.8 5845.0 5913.9 5915.3 5945.8 5967.6 1016.2 1032.2 1035.9 1040.1 1044.0 22562.3 22694.4 22935.6 22972.9 23077.0 1129.3 1135.9 1137.4 1138.1 1146.8 12060.9 12111.6 12135.4 12140.6 12174.8 216780.0 217926.0 218372.0 218408.0 219071.0 49648.5 50193.7 50208.5 50219.0 50382.5 1430.4 1483.6 1486.2 1490.4 1506.8 21972.5 22259.8 22510.7 22575.7 22741.1 36449.8 36451.8 36498.5 36501.8 36557.5 191642.0 192574.0 192650.0 193265.0 193352.0 33284.5 33500.7 33870.0 35334.3 35520.0 42357.8 44127.1 44191.0 44224.6 44398.6 32598.0 32697.3 32724.8 32932.7 33043.2 32622.8 32739.3 32822.3 32937.3 33055.2 36061.5 36245.0 36343.6 36395.1 36445.3 31807.0 31888.5 32052.4 32090.4 32257.5 23939.8 24119.3 24217.0 24627.6 24652.4 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | [#2] jquery.html Cycles:180 Average:34780.79 Median:22482.83 stddev:83723.37 (372.4%) stddev-sans-first:83918.80 13:10:24 INFO - PID 3659 | Values: 554.7 565.5 571.8 577.3 577.6 21657.5 22320.4 22502.3 22559.2 22580.7 25595.6 26135.5 26344.1 26352.0 26420.5 6585.1 6735.6 6736.3 6740.2 6745.0 4841.4 6125.5 6732.2 6781.1 6786.4 4065.7 4069.8 4073.6 6735.6 6750.1 6718.5 6727.0 6754.9 6755.9 6772.0 6202.7 6220.7 6240.8 6242.6 6261.9 28103.9 30025.7 30644.7 30647.7 30668.8 2067.9 2101.7 2104.2 2104.8 2106.9 19617.7 20064.0 20108.2 20120.7 20192.0 2375.2 2399.2 2456.0 2470.4 2471.2 131512.0 133558.0 134039.0 134529.0 136017.0 14283.4 14628.4 14694.9 14735.3 14903.4 22450.2 22463.3 22616.1 22716.1 22835.0 10024.2 10185.1 10287.3 10288.9 10354.2 8411.3 9478.3 9588.3 9711.2 9728.9 7934.8 8844.2 8939.3 9079.1 9102.0 2622.6 2628.6 2660.9 2665.7 2769.3 966.4 976.9 986.3 1002.0 1007.4 19271.4 19454.0 19688.4 19818.1 19870.6 1051.9 1053.4 1056.3 1059.2 1065.0 10646.8 10911.7 10931.6 10960.2 11048.7 489234.0 500377.0 500994.0 503681.0 505473.0 107097.5 108650.5 109610.0 110446.4 112812.0 1158.4 1181.9 1190.3 1197.9 1198.7 16670.2 17240.7 17242.9 17469.6 17626.4 53304.0 54009.5 54086.2 54713.7 54942.0 65716.3 65986.0 67336.7 67342.0 68382.7 12054.5 12637.5 14113.9 14500.3 20427.5 23799.0 24232.0 24435.3 24473.4 24501.6 17929.8 18654.5 19351.4 19449.1 19455.9 16197.4 17197.9 17247.1 17361.6 17375.0 19370.3 19397.4 19474.4 19662.8 19724.4 20330.4 20379.0 20423.5 20556.3 20559.5 16592.7 18582.5 18594.2 18686.3 18764.7 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | [#3] mootools.html Cycles:180 Average:9054.51 Median:2663.57 stddev:6322.61 (237.4%) stddev-sans-first:6313.65 13:10:24 INFO - PID 3659 | Values: 1321.4 1394.9 1395.3 1395.9 1396.2 14409.5 14502.9 15113.7 15154.7 15169.0 15105.8 15321.1 15359.0 15369.3 15402.8 2651.5 2721.8 2723.7 2727.8 2728.7 2686.7 2777.5 2778.2 2778.2 2779.0 2648.9 2680.6 2681.4 2682.2 2683.5 2590.3 2597.2 2663.5 2663.6 2666.4 2636.9 2675.9 2695.7 2698.4 2702.6 13825.9 13977.3 14000.9 14008.3 14375.0 7601.1 7869.3 7869.3 7891.6 7898.2 5185.8 5205.3 5285.6 5317.2 5392.6 1904.2 1924.6 1924.9 1949.7 1964.5 24172.4 24411.8 24545.4 24546.4 24557.8 6839.6 7286.1 7310.4 7557.4 7583.0 16417.8 16556.8 16568.3 16573.5 16591.2 7759.0 7938.8 7959.6 7966.7 7966.9 6001.4 6251.2 6431.6 7328.0 7435.9 5234.8 5342.5 5419.2 5422.9 5486.2 1549.9 1582.6 1592.8 1611.0 1617.2 845.7 863.0 881.0 884.6 893.1 7215.6 7304.5 7312.5 7337.2 7362.6 710.2 715.8 718.8 719.4 730.7 4612.1 4916.9 5499.2 5526.3 5608.0 19591.2 19890.5 20804.9 20845.5 20847.6 20148.6 20618.4 20713.8 20715.5 20795.7 10272.3 10709.8 10746.9 10964.8 10974.9 8487.0 8720.0 8929.8 8948.3 9094.5 17831.9 18089.0 18222.9 18333.4 18688.9 17958.5 18456.4 18473.1 18682.5 18771.3 11060.4 11390.1 11393.8 11418.6 11428.0 13277.9 13382.3 13549.7 13563.7 13660.7 10863.2 10885.8 11069.4 11098.3 11217.1 10732.0 10977.7 11158.2 11159.6 11162.3 9293.4 9456.6 9482.3 9484.3 9492.6 6955.7 7073.2 7092.0 7128.0 7222.0 7065.7 7149.4 7159.0 7195.8 7209.6 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | [#4] prototype.html Cycles:180 Average:5610.06 Median:6251.56 stddev:1586.69 (25.4%) stddev-sans-first:1543.92 13:10:24 INFO - PID 3659 | Values: 490.9 496.1 519.3 520.2 521.4 6320.9 6431.3 6442.9 6482.6 6559.7 6103.7 6284.8 6291.2 6323.2 6361.9 5092.6 5112.2 5135.9 5137.3 5137.8 5046.5 5061.0 5074.7 5076.9 5118.3 4905.6 5037.7 5045.7 5058.3 5073.3 5033.2 5049.0 5052.9 5080.2 5081.3 4485.8 4533.2 4559.8 4572.0 4587.1 6194.8 6215.3 6239.7 6242.8 6258.2 5765.2 5802.5 5808.1 5814.9 5820.9 6582.9 6653.0 6658.2 6690.2 6726.5 4900.4 4917.5 4927.8 4951.4 4958.0 6930.3 7003.3 7080.8 7089.6 7114.5 4980.0 5023.6 5083.9 5091.4 5117.2 5130.2 5160.9 5164.3 5184.6 5194.0 5776.5 5814.4 5822.9 5823.2 5827.6 6585.5 6647.1 6682.7 6764.5 6766.7 1663.2 1697.9 1720.8 1727.9 1746.6 1165.9 1220.7 1227.3 1242.6 1246.1 5824.3 5866.4 5943.8 5951.3 5966.9 6549.3 6693.2 6732.4 6807.6 6825.3 5872.1 5898.3 5919.7 5950.4 5958.5 3542.9 3554.0 3575.5 3604.6 3629.9 6455.6 6466.8 6506.8 6574.3 6601.2 6902.6 6932.3 6951.2 7029.4 7076.6 6518.6 6534.4 6626.0 6639.0 6645.7 6793.3 6853.7 6882.3 6896.3 6900.9 6740.4 6761.2 6799.3 6864.4 6872.6 6590.3 6595.3 6668.4 6672.2 6707.0 5055.4 5066.7 5073.7 5076.2 5105.8 6922.2 6939.4 6976.1 7005.5 7026.7 6620.2 6641.6 6645.0 6671.1 6733.4 6420.2 6635.2 6664.9 6665.6 6680.9 6245.0 6547.3 6563.5 6577.3 6644.4 6704.0 6743.5 6743.8 6759.5 6771.3 6319.2 6453.7 6467.4 6475.4 6499.2 13:10:24 INFO - PID 3659 | 13:10:24 INFO - PID 3659 | [#5] yui.html Cycles:180 Average:23002.18 Median:20000.35 stddev:30348.41 (151.7%) stddev-sans-first:30388.08 13:10:24 INFO - PID 3659 | Values: 881.2 888.8 902.3 903.2 905.3 17912.8 18474.3 18501.9 18513.5 18611.5 19049.2 20061.0 21758.8 21998.5 22114.9 977.0 998.7 1003.5 1003.6 1004.5 906.8 998.3 1008.5 1008.7 1011.0 1069.5 1070.8 1071.8 1071.9 1072.3 1064.2 1066.8 1067.0 1067.4 1068.2 781.3 781.4 781.5 783.2 783.3 19626.4 19903.9 19922.0 19939.7 20417.5 21149.2 21345.1 21479.2 21636.7 21651.9 15586.8 15683.5 15941.8 16132.5 16522.8 3777.3 3803.1 3813.2 3815.2 3817.8 114265.0 115589.4 115603.4 117023.4 118802.0 16511.5 16989.5 17018.1 17074.9 17095.6 30189.7 30963.7 31179.1 31362.8 31434.7 8591.0 8969.0 9014.1 9016.8 9030.4 4127.5 4370.8 4453.4 4462.7 4464.7 5172.4 5297.7 5308.7 5326.0 5327.7 1060.2 1089.9 1102.9 1104.6 1105.4 670.5 683.6 687.3 698.0 712.0 11636.5 11999.7 12095.3 12372.6 13076.3 657.9 692.8 696.6 700.6 707.4 5850.6 6143.7 6146.7 6597.6 6667.3 103398.0 108611.5 109471.5 111573.0 111792.0 94034.5 94767.5 95378.5 96967.5 99079.0 84160.0 86292.6 86398.1 86720.0 87236.0 12798.4 12935.0 12985.7 13078.0 13132.8 36700.8 37859.8 38134.2 38434.2 39889.0 50014.0 50730.2 50937.2 51168.7 52081.5 18455.4 18679.3 18878.3 18921.7 18954.1 20935.7 21155.0 21186.5 21200.3 21204.9 17375.6 17429.9 17514.9 17550.6 17691.9 16921.5 18810.9 19171.9 19666.9 19886.8 18655.3 18919.6 19041.9 19154.7 19470.3 13431.9 13761.7 13990.5 14345.5 14953.6 14733.9 14936.1 14936.6 15317.8 15436.4 13:10:24 INFO - PID 3659 | -------- Summary: end -------- 13:10:24 INFO - PID 3659 | 13:10:25 INFO - TEST-INFO | 3659: exit 0 13:10:25 INFO - TEST-OK | dromaeo_css | took 1114319ms 13:10:25 INFO - TEST-START | kraken 13:10:25 INFO - Initialising browser for kraken test... 13:10:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60565/getInfo.html -profile /tmp/tmpJb3pCo/profile 13:10:25 INFO - TEST-INFO | started process 4038 (/builds/slave/test/build/application/firefox/firefox http://localhost:60565/getInfo.html) 13:10:30 INFO - TEST-INFO | 4038: exit 0 13:10:30 INFO - Browser initialized. 13:10:30 INFO - Running cycle 1/1 for kraken test... 13:10:30 INFO - Using env: {'DISPLAY': ':0', 13:10:30 INFO - 'HOME': '/home/cltbld', 13:10:30 INFO - 'JSGC_DISABLE_POISONING': '1', 13:10:30 INFO - 'LANG': 'en_US.UTF-8', 13:10:30 INFO - 'LANGUAGE': 'en_US:en', 13:10:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:10:30 INFO - 'LOGNAME': 'cltbld', 13:10:30 INFO - 'MAIL': '/var/mail/cltbld', 13:10:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:30 INFO - 'MOZ_CRASHREPORTER': '1', 13:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:10:30 INFO - 'MOZ_NO_REMOTE': '1', 13:10:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:30 INFO - 'NO_EM_RESTART': '1', 13:10:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:30 INFO - 'PWD': '/builds/slave/test', 13:10:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:30 INFO - 'RUST_BACKTRACE': 'full', 13:10:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:10:30 INFO - 'SHELL': '/bin/bash', 13:10:30 INFO - 'SHLVL': '1', 13:10:30 INFO - 'STYLO_FORCE_ENABLED': '1', 13:10:30 INFO - 'TERM': 'linux', 13:10:30 INFO - 'TMOUT': '86400', 13:10:30 INFO - 'USER': 'cltbld', 13:10:30 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656', 13:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:30 INFO - '_': '/tools/buildbot/bin/python'} 13:10:30 INFO - TEST-INFO | started process 4231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJb3pCo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:31 INFO - PID 4231 | 13:10:31 INFO - PID 4231 | (/builds/slave/test/build/application/firefox/firefox:4283): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:10:31 INFO - PID 4231 | 13:10:42 INFO - PID 4231 | RSS: Main: 172404736 13:10:42 INFO - PID 4231 | 13:10:44 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:45 INFO - PID 4231 | RSS: Main: 177434624 13:10:45 INFO - PID 4231 | 13:10:48 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-dft) 13:10:48 INFO - PID 4231 | RSS: Main: 181239808 13:10:48 INFO - PID 4231 | 13:10:51 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-fft) 13:10:52 INFO - PID 4231 | RSS: Main: 174817280 13:10:52 INFO - PID 4231 | 13:10:54 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-oscillator) 13:10:55 INFO - PID 4231 | RSS: Main: 175779840 13:10:55 INFO - PID 4231 | 13:10:57 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:58 INFO - PID 4231 | RSS: Main: 175763456 13:10:58 INFO - PID 4231 | 13:11:01 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60565/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:01 INFO - PID 4231 | RSS: Main: 176529408 13:11:01 INFO - PID 4231 | 13:11:05 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60565/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:05 INFO - PID 4231 | RSS: Main: 176484352 13:11:05 INFO - PID 4231 | 13:11:08 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60565/tests/kraken/driver.html?testName=json-parse-financial) 13:11:09 INFO - PID 4231 | RSS: Main: 176889856 13:11:09 INFO - PID 4231 | 13:11:11 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:11 INFO - PID 4231 | RSS: Main: 176721920 13:11:11 INFO - PID 4231 | 13:11:13 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:14 INFO - PID 4231 | RSS: Main: 176619520 13:11:14 INFO - PID 4231 | 13:11:16 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:16 INFO - PID 4231 | RSS: Main: 173584384 13:11:16 INFO - PID 4231 | 13:11:19 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:20 INFO - PID 4231 | RSS: Main: 173518848 13:11:20 INFO - PID 4231 | 13:11:23 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:23 INFO - PID 4231 | RSS: Main: 173744128 13:11:23 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60565/tests/kraken/driver.html?testName=ai-astar) 13:11:25 INFO - PID 4231 | RSS: Main: 175476736 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | __start_tp_report 13:11:25 INFO - PID 4231 | _x_x_mozilla_page_load 13:11:25 INFO - PID 4231 | _x_x_mozilla_page_load_details 13:11:25 INFO - PID 4231 | |i|pagename|runs| 13:11:25 INFO - PID 4231 | |0;ai-astar;98;107;102;106;107;110;107;99;106;108 13:11:25 INFO - PID 4231 | |1;audio-beat-detection;149;116;138;176;120;147;139;118;167;119 13:11:25 INFO - PID 4231 | |2;audio-dft;166;164;162;161;162;160;162;164;172;165 13:11:25 INFO - PID 4231 | |3;audio-fft;74;74;73;180;75;74;73;73;144;75 13:11:25 INFO - PID 4231 | |4;audio-oscillator;79;80;134;79;80;79;122;78;79;130 13:11:25 INFO - PID 4231 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;118;117;114 13:11:25 INFO - PID 4231 | |6;imaging-darkroom;150;147;148;148;148;151;147;148;148;147 13:11:25 INFO - PID 4231 | |7;imaging-desaturate;94;95;93;99;99;99;94;94;95;95 13:11:25 INFO - PID 4231 | |8;json-parse-financial;52;52;52;52;53;52;52;51;52;61 13:11:25 INFO - PID 4231 | |9;json-stringify-tinderbox;38;38;39;38;38;38;47;39;38;38 13:11:25 INFO - PID 4231 | |10;stanford-crypto-aes;75;78;77;76;75;78;75;74;75;75 13:11:25 INFO - PID 4231 | |11;stanford-crypto-ccm;121;123;118;130;118;133;115;116;120;166 13:11:25 INFO - PID 4231 | |12;stanford-crypto-pbkdf2;183;173;167;188;179;171;176;173;173;182 13:11:25 INFO - PID 4231 | |13;stanford-crypto-sha256-iterative;67;65;65;66;68;68;63;65;69;64 13:11:25 INFO - PID 4231 | __end_tp_report 13:11:25 INFO - PID 4231 | __start_cc_report 13:11:25 INFO - PID 4231 | _x_x_mozilla_cycle_collect,937 13:11:25 INFO - PID 4231 | __end_cc_report 13:11:25 INFO - PID 4231 | __startTimestamp1504037485759__endTimestamp 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | ------- Summary: start ------- 13:11:25 INFO - PID 4231 | Number of tests: 14 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#0] ai-astar Cycles:10 Average:105.00 Median:107.50 stddev:3.97 (3.7%) stddev-sans-first:3.31 13:11:25 INFO - PID 4231 | Values: 98.0 107.0 102.0 106.0 107.0 110.0 107.0 99.0 106.0 108.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:143.00 stddev:21.21 (14.8%) stddev-sans-first:22.18 13:11:25 INFO - PID 4231 | Values: 149.0 116.0 138.0 176.0 120.0 147.0 139.0 118.0 167.0 119.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:3.43 (2.1%) stddev-sans-first:3.54 13:11:25 INFO - PID 4231 | Values: 166.0 164.0 162.0 161.0 162.0 160.0 162.0 164.0 172.0 165.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#3] audio-fft Cycles:10 Average:91.50 Median:74.00 stddev:38.12 (51.5%) stddev-sans-first:39.90 13:11:25 INFO - PID 4231 | Values: 74.0 74.0 73.0 180.0 75.0 74.0 73.0 73.0 144.0 75.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:24.10 (30.5%) stddev-sans-first:24.94 13:11:25 INFO - PID 4231 | Values: 79.0 80.0 134.0 79.0 80.0 79.0 122.0 78.0 79.0 130.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:1.54 13:11:25 INFO - PID 4231 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 118.0 117.0 114.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.32 (0.9%) stddev-sans-first:1.22 13:11:25 INFO - PID 4231 | Values: 150.0 147.0 148.0 148.0 148.0 151.0 147.0 148.0 148.0 147.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.36 (2.5%) stddev-sans-first:2.42 13:11:25 INFO - PID 4231 | Values: 94.0 95.0 93.0 99.0 99.0 99.0 94.0 94.0 95.0 95.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.00 stddev:2.88 (5.5%) stddev-sans-first:3.04 13:11:25 INFO - PID 4231 | Values: 52.0 52.0 52.0 52.0 53.0 52.0 52.0 51.0 52.0 61.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:38.00 stddev:2.81 (7.4%) stddev-sans-first:2.95 13:11:25 INFO - PID 4231 | Values: 38.0 38.0 39.0 38.0 38.0 38.0 47.0 39.0 38.0 38.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:1.40 (1.9%) stddev-sans-first:1.45 13:11:25 INFO - PID 4231 | Values: 75.0 78.0 77.0 76.0 75.0 78.0 75.0 74.0 75.0 75.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:122.00 stddev:15.22 (12.5%) stddev-sans-first:16.03 13:11:25 INFO - PID 4231 | Values: 121.0 123.0 118.0 130.0 118.0 133.0 115.0 116.0 120.0 166.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:177.50 stddev:6.40 (3.6%) stddev-sans-first:6.34 13:11:25 INFO - PID 4231 | Values: 183.0 173.0 167.0 188.0 179.0 171.0 176.0 173.0 173.0 182.0 13:11:25 INFO - PID 4231 | 13:11:25 INFO - PID 4231 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.94 (2.9%) stddev-sans-first:2.03 13:11:25 INFO - PID 4231 | Values: 67.0 65.0 65.0 66.0 68.0 68.0 63.0 65.0 69.0 64.0 13:11:25 INFO - PID 4231 | -------- Summary: end -------- 13:11:25 INFO - PID 4231 | 13:11:26 INFO - PID 4231 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:11:26 INFO - TEST-INFO | 4231: exit 0 13:11:26 INFO - TEST-OK | kraken | took 60948ms 13:11:26 INFO - SUITE-END | took 1175s 13:11:26 INFO - Completed test suite (00:19:35) 13:11:26 INFO - javascript benchmark 13:11:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8551.954433469811, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.7514686398513, 3315.8839440619577, 3325.8170800605963, 3347.564816573845, 3352.4468462703653, 6276.0, 6356.2054743157105, 6357.872842543146, 6382.0, 6383.138276332694, 6151.4463698267145, 6274.152989346437, 6282.591631543946, 6289.622622642644, 6291.528135389853, 5758.856028599276, 5762.6254293471, 5778.162166485857, 5796.30444346679, 5799.884002319951, 5790.160426738121, 5803.622764520293, 5829.329627092875, 5839.9124013139835, 5900.380460051697, 5898.970505147468, 5915.378885217055, 5937.85155371117, 5939.109133629969, 5943.138244954501, 5835.066389377679, 5847.104047421307, 5860.120981852713, 5897.734601942923, 5909.4090590941, 5090.796368145269, 5541.390447050821, 5669.348024977139, 5674.631148975303, 5823.88352232953, 6327.588706734047, 6328.208973878265, 6404.1674582304, 6417.518686098561, 6421.325760795143, 6736.730530778763, 6788.8302792430095, 6789.932100679029, 6851.9657401712675, 6889.586624802478, 6904.896426553606, 6905.240423553405, 6946.444284457231, 6949.0, 6949.5135340526185, 6390.456811171056, 6422.775202867924, 6424.229092508882, 6428.357164283628, 6431.807045788587, 7011.579305241702, 7023.473239507058, 7024.192217894905, 7126.394256488153, 7128.322809333105, 6495.967520162463, 6596.86806263872, 6611.636360000246, 6682.665866706742, 6801.693923773442, 6606.992533261582, 6684.398404143651, 6694.129763130762, 6695.665216739144, 6787.660616969132, 6726.3946244837225, 6752.459803215731, 6755.392014718601, 6827.829304267433, 6837.931620683829, 6771.322867713189, 6778.93221067783, 6882.621455819878, 6889.311068893171, 6890.965545172242, 5310.070737620901, 5316.494932981361, 5378.51593356592, 5391.110466773017, 5400.21696853954, 4576.039031803292, 4660.743659098782, 4675.6727029108315, 4679.555442232982, 4705.858824235278, 6027.7287522061615, 6035.275766907999, 6037.335893051761, 6051.273847138372, 6053.788117415869, 6797.694103765342, 6809.421199198025, 6911.205211400653, 6912.997615345746, 6918.481113916477, 5946.345901950782, 5966.552508561876, 6040.214772079602, 6044.274687037584, 6048.909266361008, 5685.772569097273, 5782.2483077199695, 5838.182654428383, 5889.852753681106, 5910.52715782745, 6561.0814485972005, 6570.047343135218, 6573.769918052845, 6579.47364210862, 6652.234992975773, 6867.3476019778045, 6872.759453419107, 6936.861262774615, 6956.826079348057, 6971.198312193959, 6546.149000629887, 6551.6069035858, 6561.967190164019, 6666.0, 6679.632620205741, 6632.204135503771, 6650.767223147167, 6651.767188148391, 6667.633280169637, 6668.499862510428, 6867.553609015398, 6903.930960690329, 6962.234154242928, 6968.442524597918, 6969.372756451944, 6613.834654133685, 6633.900491492728, 6638.302978187221, 6720.630365329954, 6730.629815360006, 6424.710888009958, 6533.509986750918, 6604.405603495708, 6610.0, 6725.461963042847, 6536.215654121535, 6553.5084868635995, 6558.573692709959, 6558.606483610999, 6562.212534495891, 6516.152900122954, 6517.478601711947, 6662.866742665216, 6698.66506674674, 6757.560758550679, 6430.678466076771, 6498.252700939453, 6515.837104072436, 6528.67356632176, 6534.869302613826], "value": 6213.802709062616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.6432534010377, 876.8071024374638, 906.5965645287849, 913.5797533134757, 1139.5043156227048, 30135.095947121594, 30817.537736933962, 39834.0, 40882.38676419856, 40915.59084409155, 41005.0, 41386.58613413865, 41474.792626036906, 41489.0, 41527.792361038155, 7667.463277570572, 7754.340881025106, 7876.094249161334, 7901.48640338379, 7903.565303908283, 7730.884036739425, 7836.568988705619, 7841.137474877787, 7842.137364889858, 7848.803779905519, 7821.765347039598, 7867.606619669023, 7871.370290376756, 7880.80297992549, 7888.684452621888, 7821.452498325119, 7841.803954901116, 7843.254890785395, 7848.6860525579195, 7854.214578542157, 7664.65509052094, 7690.653920573532, 7698.0, 7703.1526532081425, 7708.0, 36942.0, 37094.25811483782, 37122.443163352575, 37142.0, 37227.62772372269, 3568.750187486877, 3575.302815950891, 3580.6419358064245, 3600.6759391654878, 3605.56733192016, 30588.8470557648, 30838.38323233545, 30882.845585772153, 30907.227319317197, 30910.690893091007, 5175.560077393426, 5195.610329225286, 5226.817061402832, 5243.056249875021, 5247.449017853109, 181603.0, 182485.0, 183141.99999999866, 183422.0, 183966.0, 46009.539904600526, 46014.0, 46274.30588541175, 46281.07437851224, 46356.3046554302, 48275.0, 48318.516814831404, 48470.0, 48601.75699121482, 48612.27081593779, 15661.843381566267, 15893.682126357407, 16006.839931600534, 16078.115703636413, 16092.758608620647, 11833.0, 12010.15928884987, 13107.868921310856, 13229.801552976713, 13276.070675052653, 13700.177989320673, 13766.380512876945, 13780.379882905294, 13791.862081379259, 13930.791038134435, 5845.0, 5913.852153696106, 5915.349311575723, 5945.791897283574, 5967.5524335675, 1016.2479764973866, 1032.1639472027682, 1035.8653375061194, 1040.095117247984, 1043.9634612788668, 22562.32313030612, 22694.432639183822, 22935.587745620785, 22972.88513557455, 23077.0, 1129.3054771315747, 1135.914806389524, 1137.4256000719583, 1138.1009002887793, 1146.8107762219308, 12060.939695301468, 12111.576094836639, 12135.393230338448, 12140.635780926586, 12174.756504869853, 216780.0, 217926.0, 218372.0, 218408.0, 219071.0, 49648.50351496511, 50193.74903125534, 50208.497915021115, 50219.0, 50382.49617503778, 1430.3634882477197, 1483.5994281543922, 1486.1751727790963, 1490.4038384646228, 1506.7513860213162, 21972.450688732908, 22259.77740222577, 22510.662340064584, 22575.66136507921, 22741.09035638556, 36449.817750911076, 36451.81774091112, 36498.452523212705, 36501.81749091238, 36557.45163822491, 191642.0, 192574.0, 192650.0, 193265.0, 193352.0, 33284.500732488545, 33500.66499335073, 33870.0, 35334.29331413409, 35520.0, 42357.788211058745, 44127.11745765131, 44191.0, 44224.55775442333, 44398.55807930595, 32598.0, 32697.34605307928, 32724.83637581797, 32932.67067329392, 33043.173920652174, 32622.83688581542, 32739.34521309608, 32822.34355312928, 32937.341253175284, 33055.173620658716, 36061.45907811332, 36245.0, 36343.63656363403, 36395.09012274714, 36445.27109457849, 31807.04578862638, 31888.521672174473, 32052.35895282035, 32090.35819283648, 32257.51613725749, 23939.76060239375, 24119.276421707378, 24217.0, 24627.630585540872, 24652.38369040788], "value": 17063.09836601691, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.6616563896024, 565.524959034411, 571.7770069672825, 577.3331801768957, 577.5552824325272, 21657.458563535918, 22320.441988950242, 22502.3249302521, 22559.210427635036, 22580.66129008066, 25595.61606575903, 26135.47729045418, 26344.0779572715, 26352.0, 26420.471590568177, 6585.078089067534, 6735.629540375277, 6736.29268926763, 6740.191177058759, 6745.021971814084, 4841.394825646794, 6125.479334256594, 6732.2257940336995, 6781.084553585277, 6786.423154031913, 4065.7357271777387, 4069.7965101744944, 4073.63337299643, 6735.629540375277, 6750.088738020353, 6718.49611279156, 6727.024581435664, 6754.898676519856, 6755.898661520081, 6772.0, 6202.720877560476, 6220.720067596969, 6240.812775616739, 6242.563020588561, 6261.906071408933, 28103.85948070267, 30025.699743002726, 30644.69355306463, 30647.693523064707, 30668.8466557668, 2067.8966051697507, 2101.6952541881496, 2104.2004038465284, 2104.778998205182, 2106.926257580977, 19617.705734413994, 20064.0, 20108.195672173097, 20120.698189527167, 20192.0, 2375.2082115183493, 2399.196269249803, 2456.0421435640114, 2470.4441500662388, 2471.209213051824, 131512.0, 133557.99999999904, 134039.0, 134529.0, 136017.0, 14283.357248923823, 14628.414863405558, 14694.853051469563, 14735.263236838115, 14903.403863845542, 22450.214242501435, 22463.32610021702, 22616.0953561859, 22716.09135634556, 22835.0, 10024.19806415485, 10185.148158515627, 10287.331323463952, 10288.897111028793, 10354.17166626668, 8411.317736452735, 9478.336516443782, 9588.280878934107, 9711.174550163174, 9728.854067188999, 7934.801629959297, 8844.248238899638, 8939.329550283755, 9079.092090790868, 9101.95449022764, 2622.632831403605, 2628.6319915211884, 2660.86695665216, 2665.65346504957, 2769.2661444717164, 966.3766870368573, 976.9023097690174, 986.2898712926682, 1002.0230275481493, 1007.3754272351042, 19271.421857344303, 19454.0, 19688.357653834086, 19818.108185131703, 19870.60258794816, 1051.9105876000472, 1053.3890343600692, 1056.3028401255135, 1059.1526778577108, 1065.0414626835754, 10646.840297395545, 10911.672649820519, 10931.56273749057, 10960.232783705063, 11048.723781905355, 489234.0, 500377.0, 500994.0, 503681.0, 505473.0, 107097.46451267693, 108650.45674771575, 109610.0, 110446.44776776065, 112812.0, 1158.4381574936149, 1181.9468123934444, 1190.2560899438024, 1197.9041676665845, 1198.6823491774687, 16670.24983875704, 17240.741388878927, 17242.913785430992, 17469.563260918578, 17626.383076592258, 53304.0, 54009.45990540044, 54086.18870717021, 54713.72643136759, 54942.0, 65716.34283657293, 65986.0, 67336.6633166831, 67342.0, 68382.65808670924, 12054.457549410123, 12637.494500219887, 14113.858861411665, 14500.34748436344, 20427.4893127673, 23799.0, 24232.0, 24435.26694199177, 24473.38816529601, 24501.632475512524, 17929.82070179334, 18654.53363665919, 19351.4194574163, 19449.124789384794, 19455.90272048631, 16197.352105915632, 17197.914010429868, 17247.137643118043, 17361.56596085108, 17375.04437255963, 19370.322038728576, 19397.4180774577, 19474.415767526996, 19662.80337196667, 19724.40826775199, 20330.390088297376, 20379.0, 20423.489412764204, 20556.28053018137, 20559.486012849797, 16592.66814663676, 18582.535436614195, 18594.163262652943, 18686.252549898396, 18764.718529222344], "value": 12001.981551883388, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.3789518926103, 1394.8744612984829, 1395.3372148229591, 1395.902286839921, 1396.2390497179038, 14409.495667651621, 14502.854971450282, 15113.697726045486, 15154.696906061887, 15169.014014089076, 15105.773413398807, 15321.080735155898, 15359.0, 15369.308381122848, 15402.768958465633, 2651.4829608226355, 2721.8366897986084, 2723.700392956773, 2727.7954153438473, 2728.6998430172666, 2686.717894621066, 2777.5139350613663, 2778.152663437661, 2778.2220978126156, 2778.9856702303714, 2648.880800363979, 2680.6113113598517, 2681.4368982513697, 2682.235562864584, 2683.476722039203, 2590.3265151060764, 2597.1559243245924, 2663.5205662980657, 2663.613776002488, 2666.440047589999, 2636.907708230222, 2675.9464810703676, 2695.663042119735, 2698.352395425084, 2702.63514425552, 13825.930870345584, 13977.301134943213, 14000.92999535006, 14008.29958502081, 14375.0, 7601.0878694557005, 7869.291763741234, 7869.331106855924, 7891.644875980594, 7898.170692077364, 5185.818496352609, 5205.27126202332, 5285.550728188108, 5317.175837745156, 5392.56859451243, 1904.228787341129, 1924.5765931495048, 1924.9326273580357, 1949.6588097083095, 1964.489232799468, 24172.39569010771, 24411.755882441303, 24545.386365341008, 24546.386340341454, 24557.754422455724, 6839.555428897205, 7286.125664920138, 7310.378617817439, 7557.395408367427, 7583.0, 16417.83582164187, 16556.75164872528, 16568.337266509203, 16573.50279491617, 16591.170441477876, 7758.9612051939375, 7938.761837144895, 7959.562224077616, 7966.681332746625, 7966.920330796734, 6001.399860014051, 6251.187345645037, 6431.5819471734185, 7328.047353843966, 7435.925640743631, 5234.816781412632, 5342.465753424626, 5419.214213938957, 5422.891542169214, 5486.177073439016, 1549.8527639874194, 1582.5568840724616, 1592.816826064994, 1610.9516714498584, 1617.215650409574, 845.7420486751599, 862.9611667474978, 880.9735707928772, 884.6063501741792, 893.0756666849779, 7215.639218039182, 7304.488685791944, 7312.451566132561, 7337.156227033853, 7362.595057271901, 710.1691021504852, 715.7852644206821, 718.8023293594304, 719.4460265595567, 730.7186733107792, 4612.123696497655, 4916.901661966741, 5499.230107784913, 5526.253955715927, 5608.0, 19591.216351345785, 19890.50273743168, 20804.89597552033, 20845.478863028544, 20847.583048338947, 20148.597028059357, 20618.381448556567, 20713.79286207149, 20715.482112946996, 20795.68806467904, 10272.33229840043, 10709.839352409721, 10746.946265268623, 10964.780704385868, 10974.945125274322, 8486.957565212135, 8719.956400217958, 8929.776755581162, 8948.328875334506, 9094.454332740057, 17831.910840446235, 18089.005104719366, 18222.908885455487, 18333.449996500127, 18688.906555467136, 17958.461246162635, 18456.446306610822, 18473.07634618237, 18682.532936676693, 18771.34300299483, 11060.391678457761, 11390.145739069769, 11393.829092563452, 11418.600348987746, 11428.0, 13277.933610331887, 13382.263975481443, 13549.661258468617, 13563.728725425633, 13660.65848353799, 10863.185261105607, 10885.836712449161, 11069.391183484986, 11098.334099954029, 11217.102631789601, 10732.034116929513, 10977.725556860823, 11158.218924675195, 11159.553617855196, 11162.274452160584, 9293.395929264576, 9456.574454149717, 9482.288828337765, 9484.288678349014, 9492.620295188115, 6955.686994085379, 7073.151221853411, 7091.964540177266, 7128.0, 7221.963890180726, 7065.717371305091, 7149.356557909813, 7159.0, 7195.784126476214, 7209.567425954459], "value": 6508.487156240362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.9127358605885, 496.14273345461277, 519.3015394294672, 520.1599416941639, 521.4003895520151, 6320.873582528352, 6431.292557818636, 6442.903356449657, 6482.6434546099945, 6559.73761049558, 6103.7253323600435, 6284.780032698856, 6291.213598300213, 6323.249386516868, 6361.872762544746, 5092.618053645972, 5112.182050871861, 5135.922961155586, 5137.332146820927, 5137.816428018105, 5046.495350464961, 5061.0, 5074.695518268897, 5076.898462030757, 5118.257852611369, 4905.558499735023, 5037.697738135706, 5045.672031317971, 5058.317127187837, 5073.264376665381, 5033.169527028036, 5048.974755126219, 5052.949470505285, 5080.1617733074, 5081.314022606938, 4485.775711214459, 4533.184026875161, 4559.817607295704, 4571.988325136929, 4587.128445595359, 6194.783182588588, 6215.347388524185, 6239.65681887496, 6242.781502647431, 6258.1551490548645, 5765.1928729977835, 5802.535797136261, 5808.099744539603, 5814.883702325972, 5820.854478638025, 6582.893474088293, 6653.0, 6658.201015878126, 6690.197176338822, 6726.495512836508, 4900.431861804224, 4917.50824917509, 4927.77824997876, 4951.356323677899, 4957.950420495785, 6930.257660863128, 7003.299670033007, 7080.752173673896, 7089.574625522485, 7114.466415018895, 4979.975100124549, 5023.623228257895, 5083.872903177376, 5091.421659285634, 5117.155669314521, 5130.179171332569, 5160.948390516121, 5164.302819119446, 5184.611154163453, 5194.0, 5776.5089967352405, 5814.360420353758, 5822.941770582324, 5823.184754134425, 5827.562932780059, 6585.506087043395, 6647.138801135689, 6682.699278532477, 6764.4926630502905, 6766.650507998572, 1663.193351224655, 1697.896367361225, 1720.8365205305477, 1727.870409719251, 1746.589551455407, 1165.9417029148508, 1220.6582156996055, 1227.3188380448937, 1242.577523641966, 1246.0903540415547, 5824.271966004249, 5866.354700982888, 5943.791967281124, 5951.285845698544, 5966.940330596725, 6549.312322206195, 6693.163354580677, 6732.417881797774, 6807.625580593115, 6825.317468253234, 5872.120921305227, 5898.2867880774465, 5919.733611987471, 5950.404959504015, 5958.493528050164, 3542.929141417209, 3553.9644603553634, 3575.5173051637694, 3604.585472670624, 3629.891103266906, 6455.61266324022, 6466.773662921775, 6506.837329066811, 6574.257821677259, 6601.240857301375, 6902.585844849325, 6932.272111428228, 6951.2353641099435, 7029.4376449883885, 7076.551055687092, 6518.57629254097, 6534.4445722113205, 6626.0, 6638.966805165944, 6645.734170633121, 6793.331600935439, 6853.657317134223, 6882.311768823078, 6896.344847239504, 6900.896486552806, 6740.359665831738, 6761.188657361148, 6799.2520822708475, 6864.4165245954655, 6872.587644741331, 6590.275069742421, 6595.318193860535, 6668.433183179484, 6672.232693240339, 6706.966465167643, 5055.443901170942, 5066.721330326867, 5073.746312684425, 5076.238564215398, 5105.770240339268, 6922.203946546211, 6939.4448444125355, 6976.058232138596, 7005.509614326948, 7026.718931242897, 6620.2386725527185, 6641.634710090798, 6645.0, 6671.099401580725, 6733.360330768569, 6420.1974753155855, 6635.23694775107, 6664.933350666625, 6665.633390163393, 6680.866382672222, 6244.968775156095, 6547.312532184052, 6563.507736919654, 6577.3422657735755, 6644.4020038196795, 6703.966480167568, 6743.460523158234, 6743.8303997121275, 6759.493038022267, 6771.255161932085, 6319.178506794087, 6453.741850325934, 6467.353264673495, 6475.449586785176, 6499.2200935887995], "value": 5135.871019193112, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.193707757402, 888.8222355528892, 902.3142411767055, 903.2006674093425, 905.2893478619283, 17912.82087179128, 18474.261029558835, 18501.907490462563, 18513.537161570934, 18611.534711632197, 19049.2380304788, 20061.0, 21758.782412175875, 21998.45003874904, 22114.88942555289, 977.0376179463223, 998.7103739915416, 1003.4731765822928, 1003.5935446144323, 1004.4826914139225, 906.755176102452, 998.2612866478789, 1008.5461542305954, 1008.6620981971048, 1011.0142610954298, 1069.4866464097238, 1070.764431825001, 1071.796358691846, 1071.8767341755681, 1072.2762135558505, 1064.2443864855923, 1066.8293073108305, 1067.0290036067142, 1067.3542506783363, 1068.2148620763694, 781.2968328504335, 781.4256521456725, 781.4646966827742, 783.2246076384339, 783.3106865957977, 19626.41120766365, 19903.90048049765, 19922.0, 19939.700904486443, 20417.4895627609, 21149.15403383863, 21345.146194152214, 21479.24822631216, 21636.675449868264, 21651.891740541196, 15586.844131558653, 15683.529494115195, 15941.760873586905, 16132.516024519166, 16522.83477165225, 3777.2823163598828, 3803.1442925341853, 3813.161104556993, 3815.2178803345246, 3817.751846129993, 114265.0, 115589.4220528892, 115603.42198289039, 117023.41488292589, 118802.0, 16511.504654860375, 16989.49031529056, 17018.064006479763, 17074.914625426794, 17095.572610684583, 30189.698103019127, 30963.69036309608, 31179.06462806074, 31362.843185783924, 31434.68565314363, 8591.0, 8969.0, 9014.098590140933, 9016.819663606822, 9030.413023153475, 4127.545969943304, 4370.825166993348, 4453.421055262795, 4462.732236065782, 4464.709793863389, 5172.353455818023, 5297.708626025606, 5308.734563271821, 5325.988062268157, 5327.680339179662, 1060.2260349944584, 1089.8801131875487, 1102.862142232221, 1104.6354702948008, 1105.3975583307117, 670.4535803320279, 683.6274230544366, 687.285223367702, 697.9739782519688, 712.0316369737153, 11636.534538618529, 11999.700007499883, 12095.334756588296, 12372.62882113538, 13076.346182690828, 657.8519833037528, 692.8441100752391, 696.5994553131969, 700.6181631011111, 707.398711095575, 5850.64896106235, 6143.662098584531, 6146.7233974471255, 6597.637129957899, 6667.266600673922, 103398.0, 108611.45694271478, 109471.45264273627, 111573.0, 111792.0, 94034.52982735043, 94767.52616237012, 95378.52310738541, 96967.51516242514, 99079.0, 84160.0, 86292.56853715691, 86398.13601864026, 86720.0, 87236.0, 12798.360081996048, 12935.0, 12985.740285194432, 13078.0, 13132.803007954697, 36700.81649591735, 37859.81070094632, 38134.2373152541, 38434.2313153741, 39889.0, 50014.0, 50730.2390464136, 50937.23594146017, 51168.74415627898, 52081.47918520766, 18455.354062607745, 18679.346222882134, 18878.3392581259, 18921.716174257122, 18954.147063382457, 20935.685964710847, 21155.048022839317, 21186.470338241666, 21200.257990970244, 21204.893975530642, 17375.56561085983, 17429.912850435667, 17514.912425437793, 17550.561235969202, 17691.911540442215, 16921.492355229362, 18810.905945470186, 19171.904140479208, 19666.90166549158, 19886.801131988494, 18655.253789848255, 18919.621607568046, 19041.904790475957, 19154.71267930954, 19470.318538851072, 13431.865681343452, 13761.655958601115, 13990.510332138327, 14345.497907573184, 14953.55139345778, 14733.852661473677, 14936.103833769574, 14936.551903442914, 15317.770233446285, 15436.382544698086], "value": 9196.116403777629, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 102.0, 106.0, 107.0, 110.0, 107.0, 99.0, 106.0, 108.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 138.0, 176.0, 120.0, 147.0, 139.0, 118.0, 167.0, 119.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 161.0, 162.0, 160.0, 162.0, 164.0, 172.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 180.0, 75.0, 74.0, 73.0, 73.0, 144.0, 75.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 134.0, 79.0, 80.0, 79.0, 122.0, 78.0, 79.0, 130.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 117.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 148.0, 148.0, 151.0, 147.0, 148.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 99.0, 99.0, 99.0, 94.0, 94.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 52.0, 51.0, 52.0, 61.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 47.0, 39.0, 38.0, 38.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 77.0, 76.0, 75.0, 78.0, 75.0, 74.0, 75.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 118.0, 130.0, 118.0, 133.0, 115.0, 116.0, 120.0, 166.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 173.0, 167.0, 188.0, 179.0, 171.0, 176.0, 173.0, 173.0, 182.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 68.0, 68.0, 63.0, 65.0, 69.0, 64.0], "value": 66.0, "unit": "score"}]}]} 13:11:27 INFO - Return code: 0 13:11:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:11:27 INFO - # TBPL SUCCESS # 13:11:27 INFO - Running post-action listener: _package_coverage_data 13:11:27 INFO - Running post-action listener: _resource_record_post_action 13:11:27 INFO - [mozharness: 2017-08-29 20:11:27.062896Z] Finished run-tests step (success) 13:11:27 INFO - Running post-run listener: _resource_record_post_run 13:11:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7340032; Write bytes: 392585216; Read time: 3836; Write time: 217220 13:11:27 INFO - TinderboxPrint: CPU usage
13.1% 13:11:27 INFO - TinderboxPrint: I/O read bytes / time
7,340,032 / 3,836 13:11:27 INFO - TinderboxPrint: I/O write bytes / time
392,585,216 / 217,220 13:11:27 INFO - TinderboxPrint: CPU idle
8,263.2 (86.9%) 13:11:27 INFO - TinderboxPrint: CPU user
1,194.3 (12.6%) 13:11:27 INFO - TinderboxPrint: Swap in / out
0 / 0 13:11:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106455040; Read time: 0; Write time: 68564 13:11:27 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:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5595136; Write bytes: 286130176; Read time: 3736; Write time: 148656 13:11:27 INFO - Running post-run listener: _upload_blobber_files 13:11:27 INFO - Blob upload gear active. 13:11:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:27 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:27 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:27 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:28 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:11:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:28 INFO - (blobuploader) - INFO - Done attempting. 13:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:30 INFO - (blobuploader) - INFO - Done attempting. 13:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:31 INFO - (blobuploader) - INFO - Done attempting. 13:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:11:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:38 INFO - (blobuploader) - INFO - Done attempting. 13:11:38 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:38 INFO - Return code: 0 13:11:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9eb797cf84e800e11af6efdf7a42661bcab02fc575b02b5fb1160d2ad324c0fce3ca06558fd3699deda6f19401a637a3f3bc4b734f2cf2268892fcb6f46160", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7377187407552d4fb4ddd38097295623edd664e482d3e9396847edd35cf598ff2bc21b67c988d105fc9cb2d1b18b08299a94303c6eda6c2f8d03b8584564d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70230f54c59640ed37912a3519018867ec2bd50dac961f728b4cc0247861e09dc3d3e06a6f1302e50fd833fd5e56d432cd6f9020647cc2bf225a5cd51a1369bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1aa9cbbf7144992e1fd3cecf41fdfe21fc24a69f2a237cd922dcb3c9c93ab1aa598cd882fe8edba6fd8699fa2c087ad938435f2e9fc528b7037a65cf93de3b"} 13:11:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:38 INFO - Contents: 13:11:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9eb797cf84e800e11af6efdf7a42661bcab02fc575b02b5fb1160d2ad324c0fce3ca06558fd3699deda6f19401a637a3f3bc4b734f2cf2268892fcb6f46160", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7377187407552d4fb4ddd38097295623edd664e482d3e9396847edd35cf598ff2bc21b67c988d105fc9cb2d1b18b08299a94303c6eda6c2f8d03b8584564d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70230f54c59640ed37912a3519018867ec2bd50dac961f728b4cc0247861e09dc3d3e06a6f1302e50fd833fd5e56d432cd6f9020647cc2bf225a5cd51a1369bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1aa9cbbf7144992e1fd3cecf41fdfe21fc24a69f2a237cd922dcb3c9c93ab1aa598cd882fe8edba6fd8699fa2c087ad938435f2e9fc528b7037a65cf93de3b"} 13:11:38 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:38 INFO - Copying logs to upload dir... 13:11:38 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.688562 ========= master_lag: 1.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-29 13:11:40.287424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:40.295940) ========= 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=2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9eb797cf84e800e11af6efdf7a42661bcab02fc575b02b5fb1160d2ad324c0fce3ca06558fd3699deda6f19401a637a3f3bc4b734f2cf2268892fcb6f46160", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7377187407552d4fb4ddd38097295623edd664e482d3e9396847edd35cf598ff2bc21b67c988d105fc9cb2d1b18b08299a94303c6eda6c2f8d03b8584564d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70230f54c59640ed37912a3519018867ec2bd50dac961f728b4cc0247861e09dc3d3e06a6f1302e50fd833fd5e56d432cd6f9020647cc2bf225a5cd51a1369bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1aa9cbbf7144992e1fd3cecf41fdfe21fc24a69f2a237cd922dcb3c9c93ab1aa598cd882fe8edba6fd8699fa2c087ad938435f2e9fc528b7037a65cf93de3b"} build_url:https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011641 build_url: 'https://queue.taskcluster.net/v1/task/I8xynoCOTwiPbft2MqBxhQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a9eb797cf84e800e11af6efdf7a42661bcab02fc575b02b5fb1160d2ad324c0fce3ca06558fd3699deda6f19401a637a3f3bc4b734f2cf2268892fcb6f46160", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7377187407552d4fb4ddd38097295623edd664e482d3e9396847edd35cf598ff2bc21b67c988d105fc9cb2d1b18b08299a94303c6eda6c2f8d03b8584564d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70230f54c59640ed37912a3519018867ec2bd50dac961f728b4cc0247861e09dc3d3e06a6f1302e50fd833fd5e56d432cd6f9020647cc2bf225a5cd51a1369bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1aa9cbbf7144992e1fd3cecf41fdfe21fc24a69f2a237cd922dcb3c9c93ab1aa598cd882fe8edba6fd8699fa2c087ad938435f2e9fc528b7037a65cf93de3b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:40.337877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:40.338269) ========= 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=2432103b8b3de4003b23cad4000001c2-1504036236.118524-1815920656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.47 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:40.814108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 13:11:40.814448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 13:11:40.814845) ========= ========= Total master_lag: 2.19 =========