builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1504212742.68 results: success (0) revision: 13d241d08912be31884f9d0d0e805b25343d6c0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.678232) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.680362) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.680696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.710017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.710311) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 13:52:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.6M=0s 2017-08-31 13:52:22 (99.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.846711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.847042) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.917962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.918278) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13d241d08912be31884f9d0d0e805b25343d6c0a --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 13d241d08912be31884f9d0d0e805b25343d6c0a --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=934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 13:52:22,970 truncating revision to first 12 chars 2017-08-31 13:52:22,970 Setting DEBUG logging. 2017-08-31 13:52:22,970 attempt 1/10 2017-08-31 13:52:22,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13d241d08912?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 13:52:23,473 unpacking tar archive at: mozilla-central-13d241d08912/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.761207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.761519) ========= script_repo_revision: 13d241d08912be31884f9d0d0e805b25343d6c0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.761916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.762242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.773878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-31 13:52:23.774185) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:23 INFO - MultiFileLogger online at 20170831 13:52:23 in /builds/slave/test 13:52:23 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 13:52:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:52:23 INFO - {'append_to_log': False, 13:52:23 INFO - 'base_work_dir': '/builds/slave/test', 13:52:23 INFO - 'blob_upload_branch': 'Firefox', 13:52:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:52:23 INFO - 'branch': 'Firefox', 13:52:23 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:23 INFO - 'code_coverage': False, 13:52:23 INFO - 'config_files': ('talos/linux_config.py',), 13:52:23 INFO - 'default_actions': ('clobber', 13:52:23 INFO - 'read-buildbot-config', 13:52:23 INFO - 'download-and-extract', 13:52:23 INFO - 'populate-webroot', 13:52:23 INFO - 'create-virtualenv', 13:52:23 INFO - 'install', 13:52:23 INFO - 'setup-mitmproxy', 13:52:23 INFO - 'run-tests'), 13:52:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:23 INFO - 'disable_ccov_upload': False, 13:52:23 INFO - 'disable_stylo': False, 13:52:23 INFO - 'download_minidump_stackwalk': True, 13:52:23 INFO - 'download_symbols': 'ondemand', 13:52:23 INFO - 'enable_stylo': False, 13:52:23 INFO - 'enable_webrender': False, 13:52:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:52:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:23 INFO - 'gecko_profile': False, 13:52:23 INFO - 'gecko_profile_interval': 0, 13:52:23 INFO - 'installer_path': 'installer.exe', 13:52:23 INFO - 'log_level': 'info', 13:52:23 INFO - 'log_name': 'talos', 13:52:23 INFO - 'log_to_console': True, 13:52:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:23 INFO - 'opt_config_files': (), 13:52:23 INFO - 'pip_index': False, 13:52:23 INFO - 'suite': 'dromaeojs-e10s', 13:52:23 INFO - 'system_bits': '32', 13:52:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:23 INFO - 'title': 'talos-linux64-ix-057', 13:52:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:23 INFO - 'use_talos_json': True, 13:52:23 INFO - 'verify': 'False', 13:52:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:52:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:23 INFO - 'work_dir': 'build'} 13:52:23 INFO - [mozharness: 2017-08-31 20:52:23.968051Z] Running clobber step. 13:52:23 INFO - Running pre-action listener: _resource_record_pre_action 13:52:23 INFO - Running main action method: clobber 13:52:23 INFO - rmtree: /builds/slave/test/build 13:52:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:52:25 INFO - Running post-action listener: _resource_record_post_action 13:52:25 INFO - [mozharness: 2017-08-31 20:52:25.523849Z] Finished clobber step (success) 13:52:25 INFO - [mozharness: 2017-08-31 20:52:25.523945Z] Running read-buildbot-config step. 13:52:25 INFO - Running pre-action listener: _resource_record_pre_action 13:52:25 INFO - Running main action method: read_buildbot_config 13:52:25 INFO - Using buildbot properties: 13:52:25 INFO - { 13:52:25 INFO - "project": "", 13:52:25 INFO - "product": "firefox", 13:52:25 INFO - "who": "kwierso@gmail.com", 13:52:25 INFO - "installer_path": "public/build/target.tar.bz2", 13:52:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 13:52:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:52:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 13:52:25 INFO - "stage_platform": "linux64-stylosequential", 13:52:25 INFO - "basedir": "/builds/slave/test", 13:52:25 INFO - "buildnumber": 221, 13:52:25 INFO - "platform": "ubuntu64_hw_styloseq", 13:52:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:52:25 INFO - "slavebuilddir": "test", 13:52:25 INFO - "taskId": "Lo0hSFYTTe2VFYsvZU-0dw", 13:52:25 INFO - "branch": "mozilla-central", 13:52:25 INFO - "script_repo_revision": "production", 13:52:25 INFO - "revision": "13d241d08912be31884f9d0d0e805b25343d6c0a", 13:52:25 INFO - "slavename": "talos-linux64-ix-057", 13:52:25 INFO - "repo_path": "mozilla-central" 13:52:25 INFO - } 13:52:25 INFO - Finding installer, test and symbols from parent task. 13:52:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lo0hSFYTTe2VFYsvZU-0dw'}, attempt #1 13:52:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lo0hSFYTTe2VFYsvZU-0dw'}, attempt #1 13:52:26 INFO - Task dependencies: ZFWS62EnTCq2ZhmByr1xKg 13:52:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg'}, attempt #1 13:52:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json 13:52:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip 13:52:26 INFO - Running post-action listener: _resource_record_post_action 13:52:26 INFO - [mozharness: 2017-08-31 20:52:26.941862Z] Finished read-buildbot-config step (success) 13:52:26 INFO - [mozharness: 2017-08-31 20:52:26.942077Z] Running download-and-extract step. 13:52:26 INFO - Running pre-action listener: _resource_record_pre_action 13:52:26 INFO - Running main action method: download_and_extract 13:52:26 INFO - mkdir: /builds/slave/test/build/tests 13:52:26 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')]} 13:52:26 INFO - trying https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json 13:52:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:52:27 INFO - Downloaded 989 bytes. 13:52:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:52:27 INFO - Using the following test package requirements: 13:52:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:52:27 INFO - u'common': [u'target.common.tests.zip'], 13:52:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:52:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:52:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:52:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:52:27 INFO - u'mozbase': [u'target.common.tests.zip'], 13:52:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:52:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:52:27 INFO - u'web-platform': [u'target.common.tests.zip', 13:52:27 INFO - u'target.web-platform.tests.tar.gz'], 13:52:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:52:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:52:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip 13:52:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip into memory 13:52:28 INFO - Content-Length response header: 54932967 13:52:28 INFO - Bytes received: 54932967 13:52:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:52:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip 13:52:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip into memory 13:52:40 INFO - Content-Length response header: 54932967 13:52:40 INFO - Bytes received: 54932967 13:52:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip 13:52:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:52:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip into memory 13:52:53 INFO - Content-Length response header: 14496650 13:52:53 INFO - Bytes received: 14496650 13:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:53 INFO - trying https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:52:54 INFO - Downloaded 62641049 bytes. 13:52:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:54 INFO - mkdir: /builds/slave/test/properties 13:52:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:52:54 INFO - Writing to file /builds/slave/test/properties/build_url 13:52:54 INFO - Contents: 13:52:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:54 INFO - Running post-action listener: _resource_record_post_action 13:52:54 INFO - Running post-action listener: find_tests_for_verification 13:52:54 INFO - Running post-action listener: set_extra_try_arguments 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.788151Z] Finished download-and-extract step (success) 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.788247Z] Running populate-webroot step. 13:52:54 INFO - Running pre-action listener: _resource_record_pre_action 13:52:54 INFO - Running main action method: populate_webroot 13:52:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:54 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:54 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:54 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'tests': ['damp', 'tps']}, 13:52:54 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['damp', 'tps']}, 13:52:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:52:54 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:52:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:54 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:54 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:54 INFO - 'ts_paint', 13:52:54 INFO - 'tpaint', 13:52:54 INFO - 'sessionrestore', 13:52:54 INFO - 'sessionrestore_many_windows', 13:52:54 INFO - 'sessionrestore_no_auto_restore', 13:52:54 INFO - 'tabpaint']}, 13:52:54 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['a11yr', 13:52:54 INFO - 'ts_paint', 13:52:54 INFO - 'tpaint', 13:52:54 INFO - 'sessionrestore', 13:52:54 INFO - 'sessionrestore_many_windows', 13:52:54 INFO - 'sessionrestore_no_auto_restore', 13:52:54 INFO - 'tabpaint']}, 13:52:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:52:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:52:54 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['bloom_basic_singleton']}, 13:52:54 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['bloom_basic']}, 13:52:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:54 INFO - 'tsvgr_opacity', 13:52:54 INFO - 'tart', 13:52:54 INFO - 'tscrollx', 13:52:54 INFO - 'tsvg_static']}, 13:52:54 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tsvgx', 13:52:54 INFO - 'tsvgr_opacity', 13:52:54 INFO - 'tart', 13:52:54 INFO - 'tscrollx', 13:52:54 INFO - 'tsvg_static']}, 13:52:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:52:54 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tp5o']}, 13:52:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:54 INFO - 'talos_options': ['--mitmproxy', 13:52:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:54 INFO - '--firstNonBlankPaint'], 13:52:54 INFO - 'tests': ['tp6_google', 13:52:54 INFO - 'tp6_youtube', 13:52:54 INFO - 'tp6_amazon', 13:52:54 INFO - 'tp6_facebook']}, 13:52:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo', 13:52:54 INFO - '--mitmproxy', 13:52:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:54 INFO - '--firstNonBlankPaint'], 13:52:54 INFO - 'tests': ['tp6_google', 13:52:54 INFO - 'tp6_youtube', 13:52:54 INFO - 'tp6_amazon', 13:52:54 INFO - 'tp6_facebook']}, 13:52:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo', 13:52:54 INFO - '--stylo-threads=1', 13:52:54 INFO - '--mitmproxy', 13:52:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:54 INFO - '--firstNonBlankPaint'], 13:52:54 INFO - 'tests': ['tp6_google', 13:52:54 INFO - 'tp6_youtube', 13:52:54 INFO - 'tp6_amazon', 13:52:54 INFO - 'tp6_facebook']}, 13:52:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--xperf_path', 13:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:54 INFO - 'tests': ['tp5n']}, 13:52:54 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo', 13:52:54 INFO - '--xperf_path', 13:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:54 INFO - 'tests': ['tp5n']}}} 13:52:54 INFO - Running post-action listener: _resource_record_post_action 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.802664Z] Finished populate-webroot step (success) 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.802753Z] Running create-virtualenv step. 13:52:54 INFO - Running pre-action listener: _resource_record_pre_action 13:52:54 INFO - Running main action method: create_virtualenv 13:52:54 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:52:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:52:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:52:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:55 INFO - Installing pip...............done. 13:52:55 INFO - Return code: 0 13:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:52:55 INFO - Reading from file tmpfile_stdout 13:52:55 INFO - Output received: 13:52:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:52:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:52:55 INFO - Using env: {'DISPLAY': ':0', 13:52:55 INFO - 'HOME': '/home/cltbld', 13:52:55 INFO - 'LANG': 'en_US.UTF-8', 13:52:55 INFO - 'LANGUAGE': 'en_US:en', 13:52:55 INFO - 'LOGNAME': 'cltbld', 13:52:55 INFO - 'MAIL': '/var/mail/cltbld', 13:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:55 INFO - 'MOZ_NO_REMOTE': '1', 13:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:55 INFO - 'NO_EM_RESTART': '1', 13:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:55 INFO - 'PWD': '/builds/slave/test', 13:52:55 INFO - 'SHELL': '/bin/bash', 13:52:55 INFO - 'SHLVL': '1', 13:52:55 INFO - 'TERM': 'linux', 13:52:55 INFO - 'TMOUT': '86400', 13:52:55 INFO - 'USER': 'cltbld', 13:52:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:55 INFO - '_': '/tools/buildbot/bin/python'} 13:52:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:52:56 INFO - Downloading/unpacking pip>=1.5 13:52:56 INFO - Running setup.py egg_info for package pip 13:52:56 INFO - warning: no files found matching 'pip/cacert.pem' 13:52:56 INFO - warning: no files found matching '*.html' under directory 'docs' 13:52:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:52:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:52:56 INFO - Installing collected packages: pip 13:52:56 INFO - Found existing installation: pip 1.1 13:52:56 INFO - Uninstalling pip: 13:52:56 INFO - Successfully uninstalled pip 13:52:56 INFO - Running setup.py install for pip 13:52:56 INFO - warning: no files found matching 'pip/cacert.pem' 13:52:56 INFO - warning: no files found matching '*.html' under directory 'docs' 13:52:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:52:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:52:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:52:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:52:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:52:56 INFO - Successfully installed pip 13:52:56 INFO - Cleaning up... 13:52:56 INFO - Return code: 0 13:52:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:52:56 INFO - Using env: {'DISPLAY': ':0', 13:52:56 INFO - 'HOME': '/home/cltbld', 13:52:56 INFO - 'LANG': 'en_US.UTF-8', 13:52:56 INFO - 'LANGUAGE': 'en_US:en', 13:52:56 INFO - 'LOGNAME': 'cltbld', 13:52:56 INFO - 'MAIL': '/var/mail/cltbld', 13:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:56 INFO - 'MOZ_NO_REMOTE': '1', 13:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:56 INFO - 'NO_EM_RESTART': '1', 13:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:56 INFO - 'PWD': '/builds/slave/test', 13:52:56 INFO - 'SHELL': '/bin/bash', 13:52:56 INFO - 'SHLVL': '1', 13:52:56 INFO - 'TERM': 'linux', 13:52:56 INFO - 'TMOUT': '86400', 13:52:56 INFO - 'USER': 'cltbld', 13:52:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:56 INFO - '_': '/tools/buildbot/bin/python'} 13:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:57 INFO - Downloading/unpacking psutil>=3.1.1 13:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:58 INFO - Installing collected packages: psutil 13:52:58 INFO - Running setup.py install for psutil 13:52:58 INFO - building 'psutil._psutil_linux' extension 13:52:58 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 13:52:58 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 13:52:58 INFO - building 'psutil._psutil_posix' extension 13:52:58 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 13:52:58 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 13:52:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:58 INFO - Successfully installed psutil 13:52:58 INFO - Cleaning up... 13:52:58 INFO - Return code: 0 13:52:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:58 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:52:58 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 13:52:58 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 13:52:58 INFO - Using env: {'DISPLAY': ':0', 13:52:58 INFO - 'HOME': '/home/cltbld', 13:52:58 INFO - 'LANG': 'en_US.UTF-8', 13:52:58 INFO - 'LANGUAGE': 'en_US:en', 13:52:58 INFO - 'LOGNAME': 'cltbld', 13:52:58 INFO - 'MAIL': '/var/mail/cltbld', 13:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:58 INFO - 'MOZ_NO_REMOTE': '1', 13:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:58 INFO - 'NO_EM_RESTART': '1', 13:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:58 INFO - 'PWD': '/builds/slave/test', 13:52:58 INFO - 'SHELL': '/bin/bash', 13:52:58 INFO - 'SHLVL': '1', 13:52:58 INFO - 'TERM': 'linux', 13:52:58 INFO - 'TMOUT': '86400', 13:52:58 INFO - 'USER': 'cltbld', 13:52:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:58 INFO - '_': '/tools/buildbot/bin/python'} 13:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:53:00 INFO - Installing collected packages: mozsystemmonitor 13:53:00 INFO - Running setup.py install for mozsystemmonitor 13:53:00 INFO - Successfully installed mozsystemmonitor 13:53:00 INFO - Cleaning up... 13:53:00 INFO - Return code: 0 13:53:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:00 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:00 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 13:53:00 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 13:53:00 INFO - Using env: {'DISPLAY': ':0', 13:53:00 INFO - 'HOME': '/home/cltbld', 13:53:00 INFO - 'LANG': 'en_US.UTF-8', 13:53:00 INFO - 'LANGUAGE': 'en_US:en', 13:53:00 INFO - 'LOGNAME': 'cltbld', 13:53:00 INFO - 'MAIL': '/var/mail/cltbld', 13:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:00 INFO - 'MOZ_NO_REMOTE': '1', 13:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:00 INFO - 'NO_EM_RESTART': '1', 13:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:00 INFO - 'PWD': '/builds/slave/test', 13:53:00 INFO - 'SHELL': '/bin/bash', 13:53:00 INFO - 'SHLVL': '1', 13:53:00 INFO - 'TERM': 'linux', 13:53:00 INFO - 'TMOUT': '86400', 13:53:00 INFO - 'USER': 'cltbld', 13:53:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:00 INFO - '_': '/tools/buildbot/bin/python'} 13:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:00 INFO - Downloading/unpacking jsonschema==2.5.1 13:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:53:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:53:01 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 13:53:01 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 13:53:01 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 13:53:01 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 13:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:53:01 INFO - warning: no files found matching '*.txt' 13:53:01 INFO - no previously-included directories found matching 'build' 13:53:01 INFO - no previously-included directories found matching 'dist' 13:53:01 INFO - no previously-included directories found matching '.git*' 13:53:01 INFO - Installing collected packages: jsonschema, functools32 13:53:01 INFO - Running setup.py install for functools32 13:53:02 INFO - warning: no files found matching '*.txt' 13:53:02 INFO - no previously-included directories found matching 'build' 13:53:02 INFO - no previously-included directories found matching 'dist' 13:53:02 INFO - no previously-included directories found matching '.git*' 13:53:02 INFO - Successfully installed jsonschema functools32 13:53:02 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:02 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:02 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 13:53:02 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 13:53:02 INFO - Using env: {'DISPLAY': ':0', 13:53:02 INFO - 'HOME': '/home/cltbld', 13:53:02 INFO - 'LANG': 'en_US.UTF-8', 13:53:02 INFO - 'LANGUAGE': 'en_US:en', 13:53:02 INFO - 'LOGNAME': 'cltbld', 13:53:02 INFO - 'MAIL': '/var/mail/cltbld', 13:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:02 INFO - 'MOZ_NO_REMOTE': '1', 13:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:02 INFO - 'NO_EM_RESTART': '1', 13:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:02 INFO - 'PWD': '/builds/slave/test', 13:53:02 INFO - 'SHELL': '/bin/bash', 13:53:02 INFO - 'SHLVL': '1', 13:53:02 INFO - 'TERM': 'linux', 13:53:02 INFO - 'TMOUT': '86400', 13:53:02 INFO - 'USER': 'cltbld', 13:53:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:02 INFO - '_': '/tools/buildbot/bin/python'} 13:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:53:02 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:02 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:02 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 13:53:02 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 13:53:02 INFO - Using env: {'DISPLAY': ':0', 13:53:02 INFO - 'HOME': '/home/cltbld', 13:53:02 INFO - 'LANG': 'en_US.UTF-8', 13:53:02 INFO - 'LANGUAGE': 'en_US:en', 13:53:02 INFO - 'LOGNAME': 'cltbld', 13:53:02 INFO - 'MAIL': '/var/mail/cltbld', 13:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:02 INFO - 'MOZ_NO_REMOTE': '1', 13:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:02 INFO - 'NO_EM_RESTART': '1', 13:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:02 INFO - 'PWD': '/builds/slave/test', 13:53:02 INFO - 'SHELL': '/bin/bash', 13:53:02 INFO - 'SHLVL': '1', 13:53:02 INFO - 'TERM': 'linux', 13:53:02 INFO - 'TMOUT': '86400', 13:53:02 INFO - 'USER': 'cltbld', 13:53:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:02 INFO - '_': '/tools/buildbot/bin/python'} 13:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:53:02 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 13:53:02 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 13:53:02 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 13:53:02 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 13:53:03 INFO - Downloading blobuploader-1.2.4.tar.gz 13:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:53:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:53:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:04 INFO - Downloading docopt-0.6.1.tar.gz 13:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:53:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:53:04 INFO - Running setup.py install for blobuploader 13:53:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:53:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:53:04 INFO - Running setup.py install for requests 13:53:04 INFO - Running setup.py install for docopt 13:53:04 INFO - Successfully installed blobuploader requests docopt 13:53:04 INFO - Cleaning up... 13:53:04 INFO - Return code: 0 13:53:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:04 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')]} 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:04 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')]} 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:04 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:04 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 13:53:04 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 13:53:04 INFO - Using env: {'DISPLAY': ':0', 13:53:04 INFO - 'HOME': '/home/cltbld', 13:53:04 INFO - 'LANG': 'en_US.UTF-8', 13:53:04 INFO - 'LANGUAGE': 'en_US:en', 13:53:04 INFO - 'LOGNAME': 'cltbld', 13:53:04 INFO - 'MAIL': '/var/mail/cltbld', 13:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:04 INFO - 'MOZ_NO_REMOTE': '1', 13:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:04 INFO - 'NO_EM_RESTART': '1', 13:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:04 INFO - 'PWD': '/builds/slave/test', 13:53:04 INFO - 'SHELL': '/bin/bash', 13:53:04 INFO - 'SHLVL': '1', 13:53:04 INFO - 'TERM': 'linux', 13:53:04 INFO - 'TMOUT': '86400', 13:53:04 INFO - 'USER': 'cltbld', 13:53:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:04 INFO - '_': '/tools/buildbot/bin/python'} 13:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:53:05 INFO - Running setup.py (path:/tmp/pip-vg0qCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:53:05 INFO - Running setup.py (path:/tmp/pip-0XHAaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:53:05 INFO - Running setup.py (path:/tmp/pip-JuS41o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:53:05 INFO - Running setup.py (path:/tmp/pip-D99H0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:53:05 INFO - Running setup.py (path:/tmp/pip-h2oACb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:53:05 INFO - Running setup.py (path:/tmp/pip-SUXGxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:53:05 INFO - Running setup.py (path:/tmp/pip-u7SbPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:53:05 INFO - Running setup.py (path:/tmp/pip-dCmOzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:53:05 INFO - Running setup.py (path:/tmp/pip-hBsTVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:53:05 INFO - Running setup.py (path:/tmp/pip-_Dphnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:53:05 INFO - Running setup.py (path:/tmp/pip-dG2MoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:53:05 INFO - Running setup.py (path:/tmp/pip-SJcWXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:53:05 INFO - Running setup.py (path:/tmp/pip-OM0iUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:53:05 INFO - Running setup.py (path:/tmp/pip-JiNuPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:06 INFO - Running setup.py (path:/tmp/pip-6ZDGmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:53:06 INFO - Running setup.py (path:/tmp/pip-GhGszW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:53:06 INFO - Running setup.py (path:/tmp/pip-2KXRDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:53:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:53:06 INFO - Running setup.py install for manifestparser 13:53:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozcrash 13:53:06 INFO - Running setup.py install for mozdebug 13:53:06 INFO - Running setup.py install for mozdevice 13:53:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozfile 13:53:06 INFO - Running setup.py install for mozhttpd 13:53:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozinfo 13:53:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozInstall 13:53:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozleak 13:53:07 INFO - Running setup.py install for mozlog 13:53:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for moznetwork 13:53:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozprocess 13:53:07 INFO - Running setup.py install for mozprofile 13:53:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozrunner 13:53:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozscreenshot 13:53:07 INFO - Running setup.py install for moztest 13:53:07 INFO - Running setup.py install for mozversion 13:53:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:53:07 INFO - Cleaning up... 13:53:08 INFO - Return code: 0 13:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:08 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:08 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 13:53:08 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 13:53:08 INFO - Using env: {'DISPLAY': ':0', 13:53:08 INFO - 'HOME': '/home/cltbld', 13:53:08 INFO - 'LANG': 'en_US.UTF-8', 13:53:08 INFO - 'LANGUAGE': 'en_US:en', 13:53:08 INFO - 'LOGNAME': 'cltbld', 13:53:08 INFO - 'MAIL': '/var/mail/cltbld', 13:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:08 INFO - 'MOZ_NO_REMOTE': '1', 13:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:08 INFO - 'NO_EM_RESTART': '1', 13:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:08 INFO - 'PWD': '/builds/slave/test', 13:53:08 INFO - 'SHELL': '/bin/bash', 13:53:08 INFO - 'SHLVL': '1', 13:53:08 INFO - 'TERM': 'linux', 13:53:08 INFO - 'TMOUT': '86400', 13:53:08 INFO - 'USER': 'cltbld', 13:53:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:08 INFO - '_': '/tools/buildbot/bin/python'} 13:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:53:08 INFO - Running setup.py (path:/tmp/pip-C7tgS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:53:08 INFO - Running setup.py (path:/tmp/pip-r_Lge9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:53:08 INFO - Running setup.py (path:/tmp/pip-T6rRHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:53:08 INFO - Running setup.py (path:/tmp/pip-P9DMwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:53:08 INFO - Running setup.py (path:/tmp/pip-0dXMUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:53:08 INFO - Running setup.py (path:/tmp/pip-whtkwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:53:08 INFO - Running setup.py (path:/tmp/pip-5xIFSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:53:08 INFO - Running setup.py (path:/tmp/pip-v5782a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:53:08 INFO - Running setup.py (path:/tmp/pip-CvNpQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:53:08 INFO - Running setup.py (path:/tmp/pip-39XOZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:53:08 INFO - Running setup.py (path:/tmp/pip-un4jl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:53:09 INFO - Running setup.py (path:/tmp/pip-gj8u_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:53:09 INFO - Running setup.py (path:/tmp/pip-9vvRD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:53:09 INFO - Running setup.py (path:/tmp/pip-UgBlwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:09 INFO - Running setup.py (path:/tmp/pip-z_mHmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:53:09 INFO - Running setup.py (path:/tmp/pip-WcjUNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:53:09 INFO - Running setup.py (path:/tmp/pip-b98qAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:53:09 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 13:53:09 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 13:53:09 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 13:53:09 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 13:53:10 INFO - Downloading blessings-1.6.tar.gz 13:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:10 INFO - Installing collected packages: blessings 13:53:10 INFO - Running setup.py install for blessings 13:53:10 INFO - Successfully installed blessings 13:53:10 INFO - Cleaning up... 13:53:10 INFO - Return code: 0 13:53:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:53:10 INFO - Reading from file tmpfile_stdout 13:53:10 INFO - Current package versions: 13:53:10 INFO - argparse == 1.2.1 13:53:10 INFO - blessings == 1.6 13:53:10 INFO - blobuploader == 1.2.4 13:53:10 INFO - docopt == 0.6.1 13:53:10 INFO - functools32 == 3.2.3-2 13:53:10 INFO - jsonschema == 2.5.1 13:53:10 INFO - manifestparser == 1.1 13:53:10 INFO - mozInstall == 1.13 13:53:10 INFO - mozcrash == 1.0 13:53:10 INFO - mozdebug == 0.1 13:53:10 INFO - mozdevice == 0.51 13:53:10 INFO - mozfile == 1.2 13:53:10 INFO - mozhttpd == 0.7 13:53:10 INFO - mozinfo == 0.10 13:53:10 INFO - mozleak == 0.1 13:53:10 INFO - mozlog == 3.5 13:53:10 INFO - moznetwork == 0.27 13:53:10 INFO - mozprocess == 0.25 13:53:10 INFO - mozprofile == 0.28 13:53:10 INFO - mozrunner == 6.13 13:53:10 INFO - mozscreenshot == 0.1 13:53:10 INFO - mozsystemmonitor == 0.3 13:53:10 INFO - moztest == 0.8 13:53:10 INFO - mozversion == 1.4 13:53:10 INFO - psutil == 3.1.1 13:53:10 INFO - requests == 1.2.3 13:53:10 INFO - wsgiref == 0.1.2 13:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:10 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')]} 13:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:10 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')]} 13:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:11 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:11 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 13:53:11 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 13:53:11 INFO - Using env: {'DISPLAY': ':0', 13:53:11 INFO - 'HOME': '/home/cltbld', 13:53:11 INFO - 'LANG': 'en_US.UTF-8', 13:53:11 INFO - 'LANGUAGE': 'en_US:en', 13:53:11 INFO - 'LOGNAME': 'cltbld', 13:53:11 INFO - 'MAIL': '/var/mail/cltbld', 13:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:11 INFO - 'MOZ_NO_REMOTE': '1', 13:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:11 INFO - 'NO_EM_RESTART': '1', 13:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:11 INFO - 'PWD': '/builds/slave/test', 13:53:11 INFO - 'SHELL': '/bin/bash', 13:53:11 INFO - 'SHLVL': '1', 13:53:11 INFO - 'TERM': 'linux', 13:53:11 INFO - 'TMOUT': '86400', 13:53:11 INFO - 'USER': 'cltbld', 13:53:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:11 INFO - '_': '/tools/buildbot/bin/python'} 13:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:53:11 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 13:53:11 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 13:53:11 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 13:53:11 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 13:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:53:12 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)) 13:53:12 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)) 13:53:12 INFO - Installing collected packages: simplejson 13:53:12 INFO - Running setup.py install for simplejson 13:53:12 INFO - building 'simplejson._speedups' extension 13:53:12 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 13:53:13 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 13:53:13 INFO - Successfully installed simplejson 13:53:13 INFO - Cleaning up... 13:53:13 INFO - Return code: 0 13:53:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:53:13 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')]} 13:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:13 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')]} 13:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:13 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 0x15fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', '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 13:53:13 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 13:53:13 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 13:53:13 INFO - Using env: {'DISPLAY': ':0', 13:53:13 INFO - 'HOME': '/home/cltbld', 13:53:13 INFO - 'LANG': 'en_US.UTF-8', 13:53:13 INFO - 'LANGUAGE': 'en_US:en', 13:53:13 INFO - 'LOGNAME': 'cltbld', 13:53:13 INFO - 'MAIL': '/var/mail/cltbld', 13:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:13 INFO - 'MOZ_NO_REMOTE': '1', 13:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:13 INFO - 'NO_EM_RESTART': '1', 13:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:13 INFO - 'PWD': '/builds/slave/test', 13:53:13 INFO - 'SHELL': '/bin/bash', 13:53:13 INFO - 'SHLVL': '1', 13:53:13 INFO - 'TERM': 'linux', 13:53:13 INFO - 'TMOUT': '86400', 13:53:13 INFO - 'USER': 'cltbld', 13:53:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:13 INFO - '_': '/tools/buildbot/bin/python'} 13:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:53:13 INFO - Cleaning up... 13:53:13 INFO - Return code: 0 13:53:13 INFO - Running post-action listener: _resource_record_post_action 13:53:13 INFO - Running post-action listener: _start_resource_monitoring 13:53:13 INFO - Starting resource monitoring. 13:53:13 INFO - [mozharness: 2017-08-31 20:53:13.671619Z] Finished create-virtualenv step (success) 13:53:13 INFO - [mozharness: 2017-08-31 20:53:13.672130Z] Running install step. 13:53:13 INFO - Running pre-action listener: _resource_record_pre_action 13:53:13 INFO - Running main action method: install 13:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:53:13 INFO - Reading from file tmpfile_stdout 13:53:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:53:14 INFO - Reading from file tmpfile_stdout 13:53:14 INFO - Output received: 13:53:14 INFO - Usage: mozinstall [options] installer 13:53:14 INFO - Options: 13:53:14 INFO - -h, --help show this help message and exit 13:53:14 INFO - -d DEST, --destination=DEST 13:53:14 INFO - Directory to install application into. [default: 13:53:14 INFO - "/builds/slave/test"] 13:53:14 INFO - --app=APP Application being installed. [default: firefox] 13:53:14 INFO - mkdir: /builds/slave/test/build/application 13:53:14 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'] 13:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:53:30 INFO - Reading from file tmpfile_stdout 13:53:30 INFO - Output received: 13:53:30 INFO - /builds/slave/test/build/application/firefox/firefox 13:53:30 INFO - Running post-action listener: _resource_record_post_action 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.503623Z] Finished install step (success) 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.503873Z] Running setup-mitmproxy step. 13:53:30 INFO - Running pre-action listener: _resource_record_pre_action 13:53:30 INFO - Running main action method: setup_mitmproxy 13:53:30 INFO - Skipping: mitmproxy is not required 13:53:30 INFO - Running post-action listener: _resource_record_post_action 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.504986Z] Finished setup-mitmproxy step (success) 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.505205Z] Running run-tests step. 13:53:30 INFO - Running pre-action listener: _resource_record_pre_action 13:53:30 INFO - Running pre-action listener: _set_gcov_prefix 13:53:30 INFO - Running main action method: run_tests 13:53:30 WARNING - Try message not found. 13:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:53:30 INFO - Python 2.7.3 13:53:30 INFO - Return code: 0 13:53:30 INFO - grabbing minidump binary from tooltool 13:53:30 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')]} 13:53:30 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 0x196c090>, '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 0x196cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1966f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:53:30 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 13:53:30 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 13:53:30 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 13:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:30 INFO - Return code: 0 13:53:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:53:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:53:30 INFO - ENV: RUST_BACKTRACE is now full 13:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:53:30 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/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 13:53:30 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/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 13:53:30 INFO - Using env: {'DISPLAY': ':0', 13:53:30 INFO - 'HOME': '/home/cltbld', 13:53:30 INFO - 'LANG': 'en_US.UTF-8', 13:53:30 INFO - 'LANGUAGE': 'en_US:en', 13:53:30 INFO - 'LOGNAME': 'cltbld', 13:53:30 INFO - 'MAIL': '/var/mail/cltbld', 13:53:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:30 INFO - 'MOZ_NO_REMOTE': '1', 13:53:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:30 INFO - 'NO_EM_RESTART': '1', 13:53:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:30 INFO - 'PWD': '/builds/slave/test', 13:53:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:30 INFO - 'RUST_BACKTRACE': 'full', 13:53:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:30 INFO - 'SHELL': '/bin/bash', 13:53:30 INFO - 'SHLVL': '1', 13:53:30 INFO - 'STYLO_FORCE_ENABLED': '1', 13:53:30 INFO - 'STYLO_THREADS': '1', 13:53:30 INFO - 'TERM': 'linux', 13:53:30 INFO - 'TMOUT': '86400', 13:53:30 INFO - 'USER': 'cltbld', 13:53:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:30 INFO - '_': '/tools/buildbot/bin/python'} 13:53:30 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/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 13:53:30 INFO - mozversion application_buildid: 20170831195811 13:53:30 INFO - mozversion application_changeset: 13d241d08912be31884f9d0d0e805b25343d6c0a 13:53:30 INFO - mozversion application_display_name: Nightly 13:53:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:30 INFO - mozversion application_name: Firefox 13:53:30 INFO - mozversion application_remotingname: firefox 13:53:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:53:30 INFO - mozversion application_vendor: Mozilla 13:53:30 INFO - mozversion application_version: 57.0a1 13:53:30 INFO - mozversion platform_buildid: 20170831195811 13:53:30 INFO - mozversion platform_changeset: 13d241d08912be31884f9d0d0e805b25343d6c0a 13:53:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:53:30 INFO - mozversion platform_version: 57.0a1 13:53:30 INFO - using testdate: 1504212810 13:53:30 INFO - actual date: 1504212810 13:53:30 INFO - starting webserver on 'localhost:57297' 13:53:30 INFO - SUITE-START | Running 2 tests 13:53:30 INFO - TEST-START | dromaeo_css 13:53:30 INFO - Initialising browser for dromaeo_css test... 13:53:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57297/getInfo.html -profile /tmp/tmpfvXvhG/profile 13:53:30 INFO - TEST-INFO | started process 10384 (/builds/slave/test/build/application/firefox/firefox http://localhost:57297/getInfo.html) 13:53:36 INFO - TEST-INFO | 10384: exit 0 13:53:36 INFO - Browser initialized. 13:53:36 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:36 INFO - Using env: {'DISPLAY': ':0', 13:53:36 INFO - 'HOME': '/home/cltbld', 13:53:36 INFO - 'JSGC_DISABLE_POISONING': '1', 13:53:36 INFO - 'LANG': 'en_US.UTF-8', 13:53:36 INFO - 'LANGUAGE': 'en_US:en', 13:53:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:53:36 INFO - 'LOGNAME': 'cltbld', 13:53:36 INFO - 'MAIL': '/var/mail/cltbld', 13:53:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:36 INFO - 'MOZ_CRASHREPORTER': '1', 13:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:53:36 INFO - 'MOZ_NO_REMOTE': '1', 13:53:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:36 INFO - 'NO_EM_RESTART': '1', 13:53:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:36 INFO - 'PWD': '/builds/slave/test', 13:53:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:36 INFO - 'RUST_BACKTRACE': 'full', 13:53:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:36 INFO - 'SHELL': '/bin/bash', 13:53:36 INFO - 'SHLVL': '1', 13:53:36 INFO - 'STYLO_FORCE_ENABLED': '1', 13:53:36 INFO - 'STYLO_THREADS': '1', 13:53:36 INFO - 'TERM': 'linux', 13:53:36 INFO - 'TMOUT': '86400', 13:53:36 INFO - 'USER': 'cltbld', 13:53:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 13:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:36 INFO - '_': '/tools/buildbot/bin/python'} 13:53:36 INFO - TEST-INFO | started process 10569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvXvhG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:37 INFO - PID 10569 | 13:53:37 INFO - PID 10569 | (/builds/slave/test/build/application/firefox/firefox:10621): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:53:37 INFO - PID 10569 | 13:53:47 INFO - PID 10569 | RSS: Main: 173305856 13:53:47 INFO - PID 10569 | 13:56:46 INFO - PID 10569 | Cycle 1(1): loaded http://localhost:57297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57297/tests/dromaeo/cssquery-ext.html) 13:56:47 INFO - PID 10569 | RSS: Main: 175063040 13:56:47 INFO - PID 10569 | 13:59:49 INFO - PID 10569 | Cycle 1(1): loaded http://localhost:57297/tests/dromaeo/cssquery-ext.html (next: http://localhost:57297/tests/dromaeo/cssquery-jquery.html) 13:59:50 INFO - PID 10569 | RSS: Main: 171372544 13:59:50 INFO - PID 10569 | 14:02:52 INFO - PID 10569 | Cycle 1(1): loaded http://localhost:57297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57297/tests/dromaeo/cssquery-mootools.html) 14:02:52 INFO - PID 10569 | RSS: Main: 173998080 14:02:52 INFO - PID 10569 | 14:05:54 INFO - PID 10569 | Cycle 1(1): loaded http://localhost:57297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57297/tests/dromaeo/cssquery-prototype.html) 14:05:54 INFO - PID 10569 | RSS: Main: 172691456 14:05:54 INFO - PID 10569 | 14:08:58 INFO - PID 10569 | Cycle 1(1): loaded http://localhost:57297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57297/tests/dromaeo/cssquery-yui.html) 14:08:59 INFO - PID 10569 | RSS: Main: 171982848 14:08:59 INFO - PID 10569 | 14:12:00 INFO - PID 10569 | Cycle 1(1): loaded http://localhost:57297/tests/dromaeo/cssquery-yui.html (next: http://localhost:57297/tests/dromaeo/cssquery-dojo.html) 14:12:01 INFO - PID 10569 | RSS: Main: 176123904 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | __start_tp_report 14:12:01 INFO - PID 10569 | _x_x_mozilla_page_load 14:12:01 INFO - PID 10569 | _x_x_mozilla_page_load_details 14:12:01 INFO - PID 10569 | |i|pagename|runs| 14:12:01 INFO - PID 10569 | |0;dojo.html;3246.675332466754;3297.868085276589;3322.601287845458;3328.1180487170905;3344.3311337732443;6202.410770976756;6320.778772742955;6351.174347334846;6378.457831084352;6416.775412860557;6213.813585592439;6307.62154270744;6320.525960552965;6322.810315690525;6325.272593651732;5768.192453056565;5781.942180578203;5784.421557844224;5801.564882633798;5837.532997360201;5870.882582348372;5881.500072493843;5899.233099697033;5913.645181289115;5940.435658612425;1053.515331199775;5689.089745640719;5825.766969321222;5895.88208235835;5921.378255283198;5398.676079435247;5803.158542011427;5871.794487192928;5876.853078673024;5901.23283973085;5763.711814409263;5770.942290577124;5845.2401187845735;5869.735861886183;5881.323647780475;6211.782587609412;6273.184486016834;6277.7175027123885;6281.309056003836;6356.682165891687;6726.865462690767;6729.024291477757;6736.124303840518;6821.931780682229;6869.278725733826;6613.933860661428;6718.596884186964;6813.216480104802;6817.386435220854;6893.241743408221;6198.194234749499;6330.778422755181;6366.522510811707;6370.012648039561;6371.076193951897;6907.447404207652;6931.272216417204;7001.264867188974;7007.684654190573;7014.0531028310525;6606.075149479077;6666.433353165035;6698.12924319845;6707.66461676924;6752.3922846944015;6612.768553100715;6714.29499902513;6718.630475323806;6730.495212859055;6837.931620683829;6722.058911752359;6786.423154031962;6791.830204244933;6805.013273075377;6817.181938167352;6696.799096027127;6712.664366781642;6757.763478278237;6760.614074114893;6843.418309443654;5230;5272.525472707474;5276.5251127398715;5280.973595132076;5343.225232341367;4513.616342610849;4533.252013417749;4540.77296135192;4614.561616646413;4678.555537223959;5893.970530147321;5916.763329466859;5975.7609695612555;5982.162497250389;5999.310079340845;6780.898286525706;6797.286284940109;6808.2510923798345;6872.759453419107;6877.968304754327;5800.680962547016;5870.765169393262;5873.882522349614;5928.67392293428;5956;5714;5799.014167591519;5802.506786923074;5803.8549036274435;5839.5036421904615;6626.768063117768;6680;6714.429273511806;6719.596824190564;6720.9663951680905;6833.45332373399;6839.62382068991;6900.068490753684;6922.896156557656;6924.792256232321;6418.839529011625;6542.051402546699;6594.439472644879;6669.333066693292;6673.232578253563;6600.2409722882485;6615.470762338905;6654.367835055662;6677.799666010027;6680.665966701743;6787.524873258824;6838.316168383122;6863.38229559342;6881.587104773529;6898.344657257552;6518.967405162944;6532.477401807939;6581.605103693793;6628.5028622852515;6636;6390.137331460193;6478.902816457663;6538.378854008862;6573.80278591643;6636.435902948304;6485.805425837232;6586.242582103119;6610.041543976193;6614.90077648826;6618.305077966744;6563.0811686362995;6585.868282634417;6627;6635.4359879410795;6673.165854268216;6186;6302.936970630235;6352.333005034405;6412.166418365583;6451.967740161269 14:12:01 INFO - PID 10569 | |1;ext.html;795.2206837299447;855.2473823035727;882.7616543533246;1124.291696231374;1136.3466007045952;38812.41781373278;40112.79943600278;40222.99999999993;40260;40318.79840600797;40507.59492405075;40687.38968915468;40856;40911.38632920509;40934.18131637365;7473.514221575608;7618.162002179756;7618.923810761877;7620.809479762995;7625.199354067826;6921.134858142732;7128.180259270172;7498.512596681198;7500.474966752329;7523.548587084765;7479.102507699056;7515.962420187891;7530.736424225153;7534.585597792119;7536.698532058711;7489.887651685229;7514.173440921494;7522.435817313696;7530.322270995636;7537.585432801194;7421.0723659542555;7425.888611670829;7513.248675132498;7522.13495448025;7527.322540971284;36386.45420318697;36538.63461365379;36605.63394366049;36721.26557468862;36732.265354692754;3425.3491836550975;3448.103493091789;3456.654334566548;3457.5159477673146;3467.6185619581825;30205.546916796266;30240.546391804142;30269.848650756827;30276.54585181224;30278;5128.051310507568;5129.358830146231;5135.075686376451;5170.638055336128;5212.817551385683;187630;188366;189361;189528;190540;46321.76839115783;46413;46445.07109857851;46463.53536464592;46615.067698645835;47339;50467.24299135516;51331.23003154956;51492.48507514952;51533.227001595005;14840.10959342443;14947.626309342353;14975;14990.925045374703;15004.549863504113;10595.629152979609;11746.353950532632;11947.761044779056;11963.64109076729;11980.520779168735;11896.76206475883;15017.774733379008;15051.1721855299;15069.17119558413;15321.46374876874;6085.695715214221;6119.623084805972;6161.983272760034;6176.81469555914;6179.3820617937845;978.882534095913;1005.2812239248972;1005.9245556583139;1011.726833754882;1013.7313611892854;21880;21890.89054554717;21980.78019219787;21981.450463738216;22022.90782375672;1070.7430216747925;1089.9972025736342;1098.1050443888205;1107.1087774341572;1109.8446217529552;11445.484953177127;11609.432726581972;11651.650450486499;11702.180847340775;11747.765044699057;238478;242088;242161;242428;242468;54479;54910.17634735482;55097;55120.44879551233;55246.44753552413;1394.623451668044;1431.6492459347526;1450.4415799916897;1458.6572155543438;1460.9488667896785;26701.466170290747;26894.462110757286;27161.59257611098;27230.319242019108;27493.587596185673;35256.823715881255;35394.8230258847;35471.64528354684;35494.46758298576;35530;210167;210594;210678;211028;211071;32467.837660811543;32727.836360818044;32956;35295.823520883256;36345.636543634224;43167;44231;44334.55665443304;44467.55532444763;44609.10781784411;31853.522197166596;32288.515672264464;32888.67111328952;33490;33630;32061.839690801397;32277.35445291128;32450.513242301855;32520.83739581287;32912.835435822664;36142;36270.45594316035;36672.63327366692;36690.44964325484;36813.26373472569;31219.84390078126;31503;31508.369832602762;31896.36207275888;33400.33199335951;24332.270031899072;24467;24989.375265618506;25060.12289569856;25515.872420637777 14:12:01 INFO - PID 10569 | |2;jquery.html;566.8554518597759;571.7198572699378;572.301791813987;582.1587805620878;582.5805420097531;21871.234506792265;22622.095116195374;22726.090956361746;22733.658995115085;22765.31704048877;24805.50388992219;25346.366340841487;25472.74527254727;25531.872340638318;25539.489210215783;6671.566348187353;6833.282505336942;6840.555363901355;6843.110395648559;6847.10987571615;5981.342052374257;6260;6518.120053792748;6537.64042977636;6543.901841472381;6489.091527186198;6512.413882750551;6514.120593719858;6514.967425162868;6518.478521718251;6464.159659244268;6492.870142597145;6493.253275873264;6494.928336824419;6497.772577959772;6035.849103772397;6044.455998960115;6048.334683184846;6049.939500604982;6055.515558755289;28390.716092839015;28974.565381519293;29466.558001629994;29696.406071878657;29722;1967.07547452697;2015.2845739762467;2016.4555569996166;2018.6366454038268;2018.7173795668618;19222.327218547285;19641.31255406054;19841.9007904961;19923.90038049815;19973.600527989358;2225.732912050564;2253.267688001406;2266.195500597281;2277.9316620501413;2278.475950531387;128060;130206;130628.6937130626;131287.3435632825;131295.34352328177;14532.854671453362;15115.168665723271;15137.621559460882;15168.014079084824;15218.239088045553;22629.094836206696;22650.66024009641;22725;22772.2029728962;22856.771432285797;9932.304738668225;10016.599336026624;10029.247806414549;10157.695269141937;10200.642977495752;7871.685132594746;9188.49463279526;9243.537823108818;9291.256699464027;9382.24942004638;8165.2243036911395;9199.908000919904;9381;9407.43555386679;9432.95283523578;2713.9592906106423;2730.494858451193;2762.240383894405;2789.693133755285;2842.147355793295;966.2801213096288;992.1318846009741;994.1003391930315;998.610541888664;1003.6336737090909;20033.499162520762;20327.390178294674;20327.4918127048;20339.186432542534;20514.58970820605;973.6251543155936;1048.743057950807;1077.6282182646974;1079.0127033764174;1081.297156848055;10355.94822025885;11405.372704501166;13024.609261722164;14046.85953140476;14117.576472705836;511719;514133;521240;532543;536312;118007;118548;118943.40528297477;120484;120936.39531802284;1215.155466950461;1226.3868065967017;1257.3964497041288;1273.0642977411594;1280.6542233596876;21768.782312176674;21862.672059918797;22075.558488830455;22140.33578992633;22183.334499965025;60112.39887601243;60281.69859150676;60441.395586043574;61336.07995880154;63293.68353158205;76047;77955.22044779707;78240.60879695565;80714.19285807067;80799.59600202196;20380.69428958537;20869.582608348053;20870.791292086884;21226;21380.679289810356;22925.88537057371;23117.422064448525;23958.76041239565;24027.399315017265;24043.278701638978;18436.26254949787;18594.349197778014;18696.719549207046;18758.437246882615;18768.155433005275;16475.505734827973;16719.582010449834;16941;17100.572485687957;17215.827841721424;18579.81420185835;19418.417447476597;19538.21847126156;19578.902105489382;19718.90140549288;21054.2631007914;21197.36407907765;21409.357719268446;21476.033578489318;21483.248086316904;16549.58626034359;17612.82387176163;17673.82326176722;17880.55298617545;17884.195211215785 14:12:01 INFO - PID 10569 | |3;mootools.html;1328.7143264198198;1365.9453621855123;1384.5500212430964;1385.9653508662288;1394.6861956059888;14953.177575233358;15113.848861511382;15591.922040389782;15596.220188990548;15608.765868511982;15751.133687647174;16119.516414507583;16142;16149.192540372964;16169.272382742776;2807.354308509044;2851.3014311493607;2870.6698729646046;2870.856457177143;2872.5403935370346;2687.153546632814;2808.7331703488135;2809.7752179825666;2809.8595070246506;2812.170409729135;2721.0748345562506;2792.246093554739;2793.106206014076;2794.2315863137696;2794.3572978215025;2701.7433343832304;2773.791965602568;2774.9861250693716;2777.0141599732005;2778.2082106599523;2721.4285000149994;2741.9040333588227;2744.4785490756694;2745.835249885013;2749.408877091435;14656.193909334983;14951.925240373837;15010.174440405774;15027.624309392244;15049.172295523742;7676.769696909102;7933.087694915101;8017.639206235675;8026.959865200637;8036.276735093811;4928.950710492921;5064.670796398223;5170.741462926839;5192.662476938987;5214.8696282592855;1804.5578833185823;1842.5762074722888;1846.8430183434425;1895.848332133426;1906.256559941624;26108;26299.73700262992;26448.07431739899;26480.07319743819;26480.205593832216;6697.799066028027;6827.419669328064;6876.965615171992;6883.139607549057;6994.370506654323;17088;17204.31182752701;17230.741538876926;17257.309707611555;17258.223379947933;7594.620268986529;7894.526328420313;7910.090339611018;7923.643436045391;7938.841223175619;5994.430529099728;6055.970485017558;7375.557466552024;7403.7408690695565;7441.479096463196;5073.213651883964;5085.898282034339;5128.512731307954;5144.562712169432;5174.7930082796265;1501.196859680066;1537.408097882301;1538.415402147177;1553.184578096486;1554.6579752454443;926.2867591954292;938.5401153434768;947.6067432015774;952.4285428742837;970.2286682087757;7780.066392032879;7823.608819558999;7839.3728501719725;7861.213878612093;7999.800004999922;719.6833393306928;721.2354903801987;728.9198188199293;730.9269073092648;737.4063878577689;5121.718305493159;5325.174597937326;5522.779088836482;5625.46558076982;5667.688277144714;21807.781922180893;22628.434289142573;22679.433014174778;22768.316950491513;22769.772302276764;21296.25463108784;22140.2250921217;22155.889220553792;22360.888195559244;22450.32649020532;11214.831777523344;11507.76984460306;11521.942390288163;11540.307581545134;11543.595974140864;8212.014558253048;8275.917240827515;8307.376946728898;8350.123237060021;8398.622062007102;18519.814801851808;18895.43313700591;19202.519937001685;19205.8079419204;19234.615307693486;18613;19326.806731932502;19467.61064778668;19914.800851991295;19929.800701992794;11145;11467.082633389477;11559.537618495166;11560.768784624091;11583;14021.29893505341;14135.858641413866;14281.357338919566;14285;14311.856881431053;10985.780284394108;11074.280171788809;11203.831942520706;11389.373584452935;11538.653840384803;10790.35257884498;10799.460026998775;10808.783824323313;11019.614313498989;11022.779544409228;8584.399092063495;8637.093105224112;8650.610722517376;8666.263367613823;8668.393212475066;6375.107484952203;6383.6808159592765;6460;6484;6660.866782664417;6970.233274339717;7020.473464490082;7091.893621595577;7282.308180722823;7469.029026226774 14:12:01 INFO - PID 10569 | |4;prototype.html;481.87471257473044;503.90677724620934;517.880887395899;519.7453247908525;521.7521677203329;6089;6192.133101365806;6193.986954239873;6202.8910170542;6226;6057.36397678243;6085.4827339676185;6094.390560943903;6102.071005917162;6142.87714245716;5121.308623335858;5122.282880396748;5137.229415587673;5140.357455318085;5152.201408781645;4847.1517484440255;4889.364382630253;5126.7436628168625;5144.1254986652175;5165.8450246492475;4879.51204879511;4912.778924948386;4923.310736496894;4943.480934501879;4954;4876;4883.780229889663;4909.159065350494;4940.51784464661;4971.900561988758;4301.5698430157045;4378.868633940987;4379.43067401239;4423.159599676052;4471.396361491222;5909.793157239519;5953.196318496991;5954.672493012926;5954.689968206988;6049.576529642927;5553.333599968029;5641.8589535261535;5664.867026594657;5677.290338707661;5688.5733569982;6510.18622672166;6513.674316284214;6521.543491955565;6528.836779080513;6548.214214294268;4794.472608013116;4795.904081918377;4817.783199755984;4823.662343635947;4843.39457567804;6434.967825160844;6480.708368123445;6614.570052946543;6650.40390306323;6681.966590167018;4891.04624598207;4904.975475122602;4921.975390123026;4925.802967881316;4944.332515110414;4966.354373931438;5004.674696144812;5022.547970682656;5024.522670346311;5063.291139240509;5531.695756733418;5602.974393827369;5625.774969001194;5629.155626655953;5651.124075768263;6412.775552855721;6436.3587285241965;6451.548391612542;6466.773662921775;6500.919705694132;1717.668806674812;1738.1309345327336;1741.991290043567;1750.4136114401563;1755.6400937807718;1142.7885841119419;1186.4008675618757;1192.9025296727032;1209.975800484003;1220.6033039262275;5644.125160600113;5664.518515926193;5686.346070201897;5691.430856914276;5703.771849126071;6484.870302593922;6485.254195767453;6532.183477065367;6584.353911522119;6588.397582954706;5619.80330688424;5635.295588051494;5716.771329146871;5718.370979192286;5721.914171287434;3438.5014172944784;3438.5873695156242;3453.447448408293;3530.805805680712;3532.5054492371087;6423.907935650951;6445.2587952386075;6452.161219041588;6462.48300135988;6509.2839787623325;6700.865982680319;6745.426638735762;6756.358145976223;6845.452363810883;6872.931270687229;6396.424321810966;6439.871202576016;6452.451541619015;6457.903131453126;6478.967605161944;6074.544409169418;6536.182977127859;6557.639329836905;6599.307072757291;6705.7929572677385;6502.479801615954;6569.343065693392;6622.437092847162;6623.668816559057;6640.50196235294;6334.809955701337;6491.578047426902;6510.414062734377;6539.378759017885;6540.037988603305;4923.433805112458;4940.2342636891335;4959.776810043484;4962.801487940586;4965.503449655005;6479.838004049937;6612.23959244693;6660.800175994728;6757.222919364336;6787.932120678927;6323.683815809283;6415.133956915756;6432.35676432353;6472.255690595642;6484.837879053061;6439.613623182624;6474.935250647622;6476.158099447231;6488.448481879093;6507.056476810931;6375.394337537927;6397.424231819158;6409;6443.96778016107;6463.7737679181;6347.90478142819;6480.189976252968;6500.382463666133;6512.772052978123;6532.5427220096035;6272.466840318624;6291.811245662638;6322.81862757348;6337.65142917144;6369.617822930453 14:12:01 INFO - PID 10569 | |5;yui.html;871.4640496094903;871.8343514732202;902.2556390977443;905.9501727404994;908.4095338030276;17668.29326826927;17927.193276302565;18126.456206313815;18143.455696329132;18253.726194107097;20439.284625038126;21830.45423864404;21862.125514979383;21862.23482178124;21894.12423503062;941.4821847983616;974.2790335151972;980.1619615228983;980.186445250444;981.3817295104075;901.8241442918634;991.1377101921339;993.6174572789456;993.7267251505857;994;967.1054274795821;1016.2428990402124;1023.8208313545138;1027.984580231297;1028.9434081125535;1028.912542433894;1029.3206483720708;1029.3360782295415;1029.7425643589104;1031.2162756305224;759.7644730133676;759.8784194528849;760.2473551184343;760.4182800157884;761.7524304601027;16640.251188696537;17326.39357622477;18325.908370458063;18538.165782539818;18660.720089198538;20220.79779202204;20419.591608167753;20728.58542829135;21160.365189044198;21164.894175529178;15502.457413990456;16015.599610009844;16139.11234882081;16176.595585110348;16177.19114044293;3699.3896007158787;3730.6082861299715;3732.234891847165;3735.589085200626;3739.326921154191;128398.35800820935;130750.3462482691;131185.34407327996;131831;132867.99999999904;15738.134402607966;16076.43732469358;16341.918290408472;16352.509424717278;16357.345706171858;29524.261893452836;29595.408091838042;30205.848970755007;30250.69749302479;30345.24136896595;7490.5131166474;7841.921580784119;7872.763817085496;8021.679132834738;8381.832363352822;3900.395438707005;4001.7198796084576;4004.1791432756213;4005.239004589119;4032.475778148822;5019.623528235397;5052.166392545262;5108.386993560722;5121.8463446096675;5126.846194614168;1052.1582733813073;1059.5338051257422;1078.5254488025244;1079.1043433949803;1080.7784404197278;619.1115748900343;625.7872323410062;634.2040738872686;639.5906619763355;653.2259272761793;10593.788124237471;10650.573977040987;10701.143908487302;12013.519459221709;12347.444365003596;598.6049207523014;617.1914791622988;620.9658468784261;628.8710814283061;638.7093872288191;4903.754812259444;4942.777575009133;5080.974595127074;5239.345081864767;5290.444503327095;111873.44063279631;114555;116226.41886790511;118641.40679296548;119239.40380298044;95234.52382738181;96222;96666;98382;102085.48957255315;82716;83445.16554834374;83966;85007;85945.57027214824;9941.950290248502;10021.949890250502;10082.899171008195;10365.792684146425;10396.480175991019;39472.2105557893;40610.39084413677;40900.79549602352;41040.38439423471;41399;54060.18909716436;54152.45847541474;54485.45514544804;55246.44753552574;55517.72241138769;13841.930790346387;14237.430502779773;14247.287635618384;14297.857021429652;14313.713725725636;15076.321565529797;15106.697866042397;15159.09045457276;15242.466513671969;15342.15618141013;13902.23537705436;14190.503332383318;14291.499797507038;14376.640583985483;14389.856101438852;14365.497207597684;14437.927810360881;14593.1973741441;14652.926735366254;14665.853341466449;14120.505782297982;14208;14211.076280041763;14371.20958347301;14371.85628143747;9403.43579385239;9430.10414010668;9525.618975240914;9695.321327507007;9734;9603.183729383081;9621.134097931219;9713.854292185482;9794.804103918024;10038.749031274276 14:12:01 INFO - PID 10569 | __end_tp_report 14:12:01 INFO - PID 10569 | __start_cc_report 14:12:01 INFO - PID 10569 | _x_x_mozilla_cycle_collect,352 14:12:01 INFO - PID 10569 | __end_cc_report 14:12:01 INFO - PID 10569 | __startTimestamp1504213921050__endTimestamp 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | ------- Summary: start ------- 14:12:01 INFO - PID 10569 | Number of tests: 6 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | [#0] dojo.html Cycles:165 Average:6206.06 Median:6478.90 stddev:841.33 (13.0%) stddev-sans-first:811.25 14:12:01 INFO - PID 10569 | Values: 3246.7 3297.9 3322.6 3328.1 3344.3 6202.4 6320.8 6351.2 6378.5 6416.8 6213.8 6307.6 6320.5 6322.8 6325.3 5768.2 5781.9 5784.4 5801.6 5837.5 5870.9 5881.5 5899.2 5913.6 5940.4 1053.5 5689.1 5825.8 5895.9 5921.4 5398.7 5803.2 5871.8 5876.9 5901.2 5763.7 5770.9 5845.2 5869.7 5881.3 6211.8 6273.2 6277.7 6281.3 6356.7 6726.9 6729.0 6736.1 6821.9 6869.3 6613.9 6718.6 6813.2 6817.4 6893.2 6198.2 6330.8 6366.5 6370.0 6371.1 6907.4 6931.3 7001.3 7007.7 7014.1 6606.1 6666.4 6698.1 6707.7 6752.4 6612.8 6714.3 6718.6 6730.5 6837.9 6722.1 6786.4 6791.8 6805.0 6817.2 6696.8 6712.7 6757.8 6760.6 6843.4 5230.0 5272.5 5276.5 5281.0 5343.2 4513.6 4533.3 4540.8 4614.6 4678.6 5894.0 5916.8 5975.8 5982.2 5999.3 6780.9 6797.3 6808.3 6872.8 6878.0 5800.7 5870.8 5873.9 5928.7 5956.0 5714.0 5799.0 5802.5 5803.9 5839.5 6626.8 6680.0 6714.4 6719.6 6721.0 6833.5 6839.6 6900.1 6922.9 6924.8 6418.8 6542.1 6594.4 6669.3 6673.2 6600.2 6615.5 6654.4 6677.8 6680.7 6787.5 6838.3 6863.4 6881.6 6898.3 6519.0 6532.5 6581.6 6628.5 6636.0 6390.1 6478.9 6538.4 6573.8 6636.4 6485.8 6586.2 6610.0 6614.9 6618.3 6563.1 6585.9 6627.0 6635.4 6673.2 6186.0 6302.9 6352.3 6412.2 6452.0 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | [#1] ext.html Cycles:180 Average:38091.40 Median:3452.38 stddev:55742.94 (1614.6%) stddev-sans-first:55828.96 14:12:01 INFO - PID 10569 | Values: 795.2 855.2 882.8 1124.3 1136.3 38812.4 40112.8 40223.0 40260.0 40318.8 40507.6 40687.4 40856.0 40911.4 40934.2 7473.5 7618.2 7618.9 7620.8 7625.2 6921.1 7128.2 7498.5 7500.5 7523.5 7479.1 7516.0 7530.7 7534.6 7536.7 7489.9 7514.2 7522.4 7530.3 7537.6 7421.1 7425.9 7513.2 7522.1 7527.3 36386.5 36538.6 36605.6 36721.3 36732.3 3425.3 3448.1 3456.7 3457.5 3467.6 30205.5 30240.5 30269.8 30276.5 30278.0 5128.1 5129.4 5135.1 5170.6 5212.8 187630.0 188366.0 189361.0 189528.0 190540.0 46321.8 46413.0 46445.1 46463.5 46615.1 47339.0 50467.2 51331.2 51492.5 51533.2 14840.1 14947.6 14975.0 14990.9 15004.5 10595.6 11746.4 11947.8 11963.6 11980.5 11896.8 15017.8 15051.2 15069.2 15321.5 6085.7 6119.6 6162.0 6176.8 6179.4 978.9 1005.3 1005.9 1011.7 1013.7 21880.0 21890.9 21980.8 21981.5 22022.9 1070.7 1090.0 1098.1 1107.1 1109.8 11445.5 11609.4 11651.7 11702.2 11747.8 238478.0 242088.0 242161.0 242428.0 242468.0 54479.0 54910.2 55097.0 55120.4 55246.4 1394.6 1431.6 1450.4 1458.7 1460.9 26701.5 26894.5 27161.6 27230.3 27493.6 35256.8 35394.8 35471.6 35494.5 35530.0 210167.0 210594.0 210678.0 211028.0 211071.0 32467.8 32727.8 32956.0 35295.8 36345.6 43167.0 44231.0 44334.6 44467.6 44609.1 31853.5 32288.5 32888.7 33490.0 33630.0 32061.8 32277.4 32450.5 32520.8 32912.8 36142.0 36270.5 36672.6 36690.4 36813.3 31219.8 31503.0 31508.4 31896.4 33400.3 24332.3 24467.0 24989.4 25060.1 25515.9 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | [#2] jquery.html Cycles:180 Average:36440.26 Median:12495.60 stddev:87588.19 (701.0%) stddev-sans-first:87792.48 14:12:01 INFO - PID 10569 | Values: 566.9 571.7 572.3 582.2 582.6 21871.2 22622.1 22726.1 22733.7 22765.3 24805.5 25346.4 25472.7 25531.9 25539.5 6671.6 6833.3 6840.6 6843.1 6847.1 5981.3 6260.0 6518.1 6537.6 6543.9 6489.1 6512.4 6514.1 6515.0 6518.5 6464.2 6492.9 6493.3 6494.9 6497.8 6035.8 6044.5 6048.3 6049.9 6055.5 28390.7 28974.6 29466.6 29696.4 29722.0 1967.1 2015.3 2016.5 2018.6 2018.7 19222.3 19641.3 19841.9 19923.9 19973.6 2225.7 2253.3 2266.2 2277.9 2278.5 128060.0 130206.0 130628.7 131287.3 131295.3 14532.9 15115.2 15137.6 15168.0 15218.2 22629.1 22650.7 22725.0 22772.2 22856.8 9932.3 10016.6 10029.2 10157.7 10200.6 7871.7 9188.5 9243.5 9291.3 9382.2 8165.2 9199.9 9381.0 9407.4 9433.0 2714.0 2730.5 2762.2 2789.7 2842.1 966.3 992.1 994.1 998.6 1003.6 20033.5 20327.4 20327.5 20339.2 20514.6 973.6 1048.7 1077.6 1079.0 1081.3 10355.9 11405.4 13024.6 14046.9 14117.6 511719.0 514133.0 521240.0 532543.0 536312.0 118007.0 118548.0 118943.4 120484.0 120936.4 1215.2 1226.4 1257.4 1273.1 1280.7 21768.8 21862.7 22075.6 22140.3 22183.3 60112.4 60281.7 60441.4 61336.1 63293.7 76047.0 77955.2 78240.6 80714.2 80799.6 20380.7 20869.6 20870.8 21226.0 21380.7 22925.9 23117.4 23958.8 24027.4 24043.3 18436.3 18594.3 18696.7 18758.4 18768.2 16475.5 16719.6 16941.0 17100.6 17215.8 18579.8 19418.4 19538.2 19578.9 19718.9 21054.3 21197.4 21409.4 21476.0 21483.2 16549.6 17612.8 17673.8 17880.6 17884.2 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | [#3] mootools.html Cycles:180 Average:9341.33 Median:2745.16 stddev:6811.09 (248.1%) stddev-sans-first:6803.59 14:12:01 INFO - PID 10569 | Values: 1328.7 1365.9 1384.6 1386.0 1394.7 14953.2 15113.8 15591.9 15596.2 15608.8 15751.1 16119.5 16142.0 16149.2 16169.3 2807.4 2851.3 2870.7 2870.9 2872.5 2687.2 2808.7 2809.8 2809.9 2812.2 2721.1 2792.2 2793.1 2794.2 2794.4 2701.7 2773.8 2775.0 2777.0 2778.2 2721.4 2741.9 2744.5 2745.8 2749.4 14656.2 14951.9 15010.2 15027.6 15049.2 7676.8 7933.1 8017.6 8027.0 8036.3 4929.0 5064.7 5170.7 5192.7 5214.9 1804.6 1842.6 1846.8 1895.8 1906.3 26108.0 26299.7 26448.1 26480.1 26480.2 6697.8 6827.4 6877.0 6883.1 6994.4 17088.0 17204.3 17230.7 17257.3 17258.2 7594.6 7894.5 7910.1 7923.6 7938.8 5994.4 6056.0 7375.6 7403.7 7441.5 5073.2 5085.9 5128.5 5144.6 5174.8 1501.2 1537.4 1538.4 1553.2 1554.7 926.3 938.5 947.6 952.4 970.2 7780.1 7823.6 7839.4 7861.2 7999.8 719.7 721.2 728.9 730.9 737.4 5121.7 5325.2 5522.8 5625.5 5667.7 21807.8 22628.4 22679.4 22768.3 22769.8 21296.3 22140.2 22155.9 22360.9 22450.3 11214.8 11507.8 11521.9 11540.3 11543.6 8212.0 8275.9 8307.4 8350.1 8398.6 18519.8 18895.4 19202.5 19205.8 19234.6 18613.0 19326.8 19467.6 19914.8 19929.8 11145.0 11467.1 11559.5 11560.8 11583.0 14021.3 14135.9 14281.4 14285.0 14311.9 10985.8 11074.3 11203.8 11389.4 11538.7 10790.4 10799.5 10808.8 11019.6 11022.8 8584.4 8637.1 8650.6 8666.3 8668.4 6375.1 6383.7 6460.0 6484.0 6660.9 6970.2 7020.5 7091.9 7282.3 7469.0 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | [#4] prototype.html Cycles:180 Average:5444.17 Median:6065.95 stddev:1521.40 (25.1%) stddev-sans-first:1479.37 14:12:01 INFO - PID 10569 | Values: 481.9 503.9 517.9 519.7 521.8 6089.0 6192.1 6194.0 6202.9 6226.0 6057.4 6085.5 6094.4 6102.1 6142.9 5121.3 5122.3 5137.2 5140.4 5152.2 4847.2 4889.4 5126.7 5144.1 5165.8 4879.5 4912.8 4923.3 4943.5 4954.0 4876.0 4883.8 4909.2 4940.5 4971.9 4301.6 4378.9 4379.4 4423.2 4471.4 5909.8 5953.2 5954.7 5954.7 6049.6 5553.3 5641.9 5664.9 5677.3 5688.6 6510.2 6513.7 6521.5 6528.8 6548.2 4794.5 4795.9 4817.8 4823.7 4843.4 6435.0 6480.7 6614.6 6650.4 6682.0 4891.0 4905.0 4922.0 4925.8 4944.3 4966.4 5004.7 5022.5 5024.5 5063.3 5531.7 5603.0 5625.8 5629.2 5651.1 6412.8 6436.4 6451.5 6466.8 6500.9 1717.7 1738.1 1742.0 1750.4 1755.6 1142.8 1186.4 1192.9 1210.0 1220.6 5644.1 5664.5 5686.3 5691.4 5703.8 6484.9 6485.3 6532.2 6584.4 6588.4 5619.8 5635.3 5716.8 5718.4 5721.9 3438.5 3438.6 3453.4 3530.8 3532.5 6423.9 6445.3 6452.2 6462.5 6509.3 6700.9 6745.4 6756.4 6845.5 6872.9 6396.4 6439.9 6452.5 6457.9 6479.0 6074.5 6536.2 6557.6 6599.3 6705.8 6502.5 6569.3 6622.4 6623.7 6640.5 6334.8 6491.6 6510.4 6539.4 6540.0 4923.4 4940.2 4959.8 4962.8 4965.5 6479.8 6612.2 6660.8 6757.2 6787.9 6323.7 6415.1 6432.4 6472.3 6484.8 6439.6 6474.9 6476.2 6488.4 6507.1 6375.4 6397.4 6409.0 6444.0 6463.8 6347.9 6480.2 6500.4 6512.8 6532.5 6272.5 6291.8 6322.8 6337.7 6369.6 14:12:01 INFO - PID 10569 | 14:12:01 INFO - PID 10569 | [#5] yui.html Cycles:180 Average:22548.41 Median:29559.83 stddev:32675.11 (110.5%) stddev-sans-first:32726.23 14:12:01 INFO - PID 10569 | Values: 871.5 871.8 902.3 906.0 908.4 17668.3 17927.2 18126.5 18143.5 18253.7 20439.3 21830.5 21862.1 21862.2 21894.1 941.5 974.3 980.2 980.2 981.4 901.8 991.1 993.6 993.7 994.0 967.1 1016.2 1023.8 1028.0 1028.9 1028.9 1029.3 1029.3 1029.7 1031.2 759.8 759.9 760.2 760.4 761.8 16640.3 17326.4 18325.9 18538.2 18660.7 20220.8 20419.6 20728.6 21160.4 21164.9 15502.5 16015.6 16139.1 16176.6 16177.2 3699.4 3730.6 3732.2 3735.6 3739.3 128398.4 130750.3 131185.3 131831.0 132868.0 15738.1 16076.4 16341.9 16352.5 16357.3 29524.3 29595.4 30205.8 30250.7 30345.2 7490.5 7841.9 7872.8 8021.7 8381.8 3900.4 4001.7 4004.2 4005.2 4032.5 5019.6 5052.2 5108.4 5121.8 5126.8 1052.2 1059.5 1078.5 1079.1 1080.8 619.1 625.8 634.2 639.6 653.2 10593.8 10650.6 10701.1 12013.5 12347.4 598.6 617.2 621.0 628.9 638.7 4903.8 4942.8 5081.0 5239.3 5290.4 111873.4 114555.0 116226.4 118641.4 119239.4 95234.5 96222.0 96666.0 98382.0 102085.5 82716.0 83445.2 83966.0 85007.0 85945.6 9942.0 10021.9 10082.9 10365.8 10396.5 39472.2 40610.4 40900.8 41040.4 41399.0 54060.2 54152.5 54485.5 55246.4 55517.7 13841.9 14237.4 14247.3 14297.9 14313.7 15076.3 15106.7 15159.1 15242.5 15342.2 13902.2 14190.5 14291.5 14376.6 14389.9 14365.5 14437.9 14593.2 14652.9 14665.9 14120.5 14208.0 14211.1 14371.2 14371.9 9403.4 9430.1 9525.6 9695.3 9734.0 9603.2 9621.1 9713.9 9794.8 10038.7 14:12:01 INFO - PID 10569 | -------- Summary: end -------- 14:12:01 INFO - PID 10569 | 14:12:01 INFO - TEST-INFO | 10569: exit 0 14:12:01 INFO - TEST-OK | dromaeo_css | took 1110941ms 14:12:01 INFO - TEST-START | kraken 14:12:01 INFO - Initialising browser for kraken test... 14:12:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57297/getInfo.html -profile /tmp/tmpvgTTma/profile 14:12:01 INFO - TEST-INFO | started process 10942 (/builds/slave/test/build/application/firefox/firefox http://localhost:57297/getInfo.html) 14:12:07 INFO - TEST-INFO | 10942: exit 0 14:12:07 INFO - Browser initialized. 14:12:07 INFO - Running cycle 1/1 for kraken test... 14:12:07 INFO - Using env: {'DISPLAY': ':0', 14:12:07 INFO - 'HOME': '/home/cltbld', 14:12:07 INFO - 'JSGC_DISABLE_POISONING': '1', 14:12:07 INFO - 'LANG': 'en_US.UTF-8', 14:12:07 INFO - 'LANGUAGE': 'en_US:en', 14:12:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:12:07 INFO - 'LOGNAME': 'cltbld', 14:12:07 INFO - 'MAIL': '/var/mail/cltbld', 14:12:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:07 INFO - 'MOZ_CRASHREPORTER': '1', 14:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:12:07 INFO - 'MOZ_NO_REMOTE': '1', 14:12:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:07 INFO - 'NO_EM_RESTART': '1', 14:12:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:07 INFO - 'PWD': '/builds/slave/test', 14:12:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:07 INFO - 'RUST_BACKTRACE': 'full', 14:12:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:12:07 INFO - 'SHELL': '/bin/bash', 14:12:07 INFO - 'SHLVL': '1', 14:12:07 INFO - 'STYLO_FORCE_ENABLED': '1', 14:12:07 INFO - 'STYLO_THREADS': '1', 14:12:07 INFO - 'TERM': 'linux', 14:12:07 INFO - 'TMOUT': '86400', 14:12:07 INFO - 'USER': 'cltbld', 14:12:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233', 14:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:07 INFO - '_': '/tools/buildbot/bin/python'} 14:12:07 INFO - TEST-INFO | started process 11134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvgTTma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:08 INFO - PID 11134 | 14:12:08 INFO - PID 11134 | (/builds/slave/test/build/application/firefox/firefox:11186): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:12:08 INFO - PID 11134 | 14:12:19 INFO - PID 11134 | RSS: Main: 167661568 14:12:19 INFO - PID 11134 | 14:12:21 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57297/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:22 INFO - PID 11134 | RSS: Main: 172187648 14:12:22 INFO - PID 11134 | 14:12:25 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57297/tests/kraken/driver.html?testName=audio-dft) 14:12:26 INFO - PID 11134 | RSS: Main: 173334528 14:12:26 INFO - PID 11134 | 14:12:29 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57297/tests/kraken/driver.html?testName=audio-fft) 14:12:29 INFO - PID 11134 | RSS: Main: 167350272 14:12:29 INFO - PID 11134 | 14:12:31 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57297/tests/kraken/driver.html?testName=audio-oscillator) 14:12:32 INFO - PID 11134 | RSS: Main: 168603648 14:12:32 INFO - PID 11134 | 14:12:34 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:35 INFO - PID 11134 | RSS: Main: 168484864 14:12:35 INFO - PID 11134 | 14:12:38 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57297/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:39 INFO - PID 11134 | RSS: Main: 171225088 14:12:39 INFO - PID 11134 | 14:12:42 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57297/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:43 INFO - PID 11134 | RSS: Main: 170921984 14:12:43 INFO - PID 11134 | 14:12:46 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57297/tests/kraken/driver.html?testName=json-parse-financial) 14:12:46 INFO - PID 11134 | RSS: Main: 171114496 14:12:46 INFO - PID 11134 | 14:12:48 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:48 INFO - PID 11134 | RSS: Main: 170840064 14:12:48 INFO - PID 11134 | 14:12:50 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:51 INFO - PID 11134 | RSS: Main: 171102208 14:12:51 INFO - PID 11134 | 14:12:53 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:53 INFO - PID 11134 | RSS: Main: 170905600 14:12:53 INFO - PID 11134 | 14:12:56 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:57 INFO - PID 11134 | RSS: Main: 171565056 14:12:57 INFO - PID 11134 | 14:13:00 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:13:00 INFO - PID 11134 | RSS: Main: 171765760 14:13:00 INFO - PID 11134 | 14:13:02 INFO - PID 11134 | Cycle 1(1): loaded http://localhost:57297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57297/tests/kraken/driver.html?testName=ai-astar) 14:13:02 INFO - PID 11134 | RSS: Main: 173293568 14:13:02 INFO - PID 11134 | 14:13:02 INFO - PID 11134 | __start_tp_report 14:13:02 INFO - PID 11134 | _x_x_mozilla_page_load 14:13:02 INFO - PID 11134 | _x_x_mozilla_page_load_details 14:13:02 INFO - PID 11134 | |i|pagename|runs| 14:13:02 INFO - PID 11134 | |0;ai-astar;97;107;112;106;107;112;114;99;108;109 14:13:02 INFO - PID 11134 | |1;audio-beat-detection;142;118;154;177;119;145;144;116;181;119 14:13:02 INFO - PID 11134 | |2;audio-dft;163;163;162;163;162;163;165;171;167;167 14:13:02 INFO - PID 11134 | |3;audio-fft;74;74;74;172;75;74;74;75;151;75 14:13:02 INFO - PID 11134 | |4;audio-oscillator;80;80;131;80;79;79;120;79;78;140 14:13:02 INFO - PID 11134 | |5;imaging-gaussian-blur;116;114;115;115;114;113;114;114;117;115 14:13:02 INFO - PID 11134 | |6;imaging-darkroom;148;148;147;147;147;150;149;150;150;149 14:13:02 INFO - PID 11134 | |7;imaging-desaturate;94;94;94;93;93;94;94;95;95;94 14:13:03 INFO - PID 11134 | |8;json-parse-financial;52;52;53;52;54;52;52;52;57;53 14:13:03 INFO - PID 11134 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 14:13:03 INFO - PID 11134 | |10;stanford-crypto-aes;82;77;74;78;75;75;76;75;74;76 14:13:03 INFO - PID 11134 | |11;stanford-crypto-ccm;129;118;117;117;132;121;126;121;122;160 14:13:03 INFO - PID 11134 | |12;stanford-crypto-pbkdf2;172;184;170;170;169;170;170;170;170;180 14:13:03 INFO - PID 11134 | |13;stanford-crypto-sha256-iterative;69;65;65;66;63;65;63;66;64;67 14:13:03 INFO - PID 11134 | __end_tp_report 14:13:03 INFO - PID 11134 | __start_cc_report 14:13:03 INFO - PID 11134 | _x_x_mozilla_cycle_collect,945 14:13:03 INFO - PID 11134 | __end_cc_report 14:13:03 INFO - PID 11134 | __startTimestamp1504213982991__endTimestamp 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | ------- Summary: start ------- 14:13:03 INFO - PID 11134 | Number of tests: 14 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#0] ai-astar Cycles:10 Average:107.10 Median:112.00 stddev:5.47 (4.9%) stddev-sans-first:4.41 14:13:03 INFO - PID 11134 | Values: 97.0 107.0 112.0 106.0 107.0 112.0 114.0 99.0 108.0 109.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:144.50 stddev:24.06 (16.7%) stddev-sans-first:25.52 14:13:03 INFO - PID 11134 | Values: 142.0 118.0 154.0 177.0 119.0 145.0 144.0 116.0 181.0 119.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.91 (1.8%) stddev-sans-first:3.03 14:13:03 INFO - PID 11134 | Values: 163.0 163.0 162.0 163.0 162.0 163.0 165.0 171.0 167.0 167.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.00 stddev:37.07 (50.1%) stddev-sans-first:38.75 14:13:03 INFO - PID 11134 | Values: 74.0 74.0 74.0 172.0 75.0 74.0 74.0 75.0 151.0 75.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:25.11 (31.8%) stddev-sans-first:26.08 14:13:03 INFO - PID 11134 | Values: 80.0 80.0 131.0 80.0 79.0 79.0 120.0 79.0 78.0 140.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.13 14:13:03 INFO - PID 11134 | Values: 116.0 114.0 115.0 115.0 114.0 113.0 114.0 114.0 117.0 115.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.27 (0.9%) stddev-sans-first:1.33 14:13:03 INFO - PID 11134 | Values: 148.0 148.0 147.0 147.0 147.0 150.0 149.0 150.0 150.0 149.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:13:03 INFO - PID 11134 | Values: 94.0 94.0 94.0 93.0 93.0 94.0 94.0 95.0 95.0 94.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:1.60 (3.0%) stddev-sans-first:1.66 14:13:03 INFO - PID 11134 | Values: 52.0 52.0 53.0 52.0 54.0 52.0 52.0 52.0 57.0 53.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:13:03 INFO - PID 11134 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.39 (3.2%) stddev-sans-first:1.33 14:13:03 INFO - PID 11134 | Values: 82.0 77.0 74.0 78.0 75.0 75.0 76.0 75.0 74.0 76.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:124.00 stddev:12.88 (10.4%) stddev-sans-first:13.62 14:13:03 INFO - PID 11134 | Values: 129.0 118.0 117.0 117.0 132.0 121.0 126.0 121.0 122.0 160.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:170.00 stddev:5.15 (3.0%) stddev-sans-first:5.46 14:13:03 INFO - PID 11134 | Values: 172.0 184.0 170.0 170.0 169.0 170.0 170.0 170.0 170.0 180.0 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.83 (2.8%) stddev-sans-first:1.36 14:13:03 INFO - PID 11134 | Values: 69.0 65.0 65.0 66.0 63.0 65.0 63.0 66.0 64.0 67.0 14:13:03 INFO - PID 11134 | -------- Summary: end -------- 14:13:03 INFO - PID 11134 | 14:13:03 INFO - PID 11134 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:13:03 INFO - TEST-INFO | 11134: exit 0 14:13:03 INFO - TEST-OK | kraken | took 61919ms 14:13:03 INFO - SUITE-END | took 1172s 14:13:04 INFO - Completed test suite (00:19:33) 14:13:04 INFO - javascript benchmark 14:13:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8443.578495185851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.675332466754, 3297.868085276589, 3322.601287845458, 3328.1180487170905, 3344.3311337732443, 6202.410770976756, 6320.778772742955, 6351.174347334846, 6378.457831084352, 6416.775412860557, 6213.813585592439, 6307.62154270744, 6320.525960552965, 6322.810315690525, 6325.272593651732, 5768.192453056565, 5781.942180578203, 5784.421557844224, 5801.564882633798, 5837.532997360201, 5870.882582348372, 5881.500072493843, 5899.233099697033, 5913.645181289115, 5940.435658612425, 1053.515331199775, 5689.089745640719, 5825.766969321222, 5895.88208235835, 5921.378255283198, 5398.676079435247, 5803.158542011427, 5871.794487192928, 5876.853078673024, 5901.23283973085, 5763.711814409263, 5770.942290577124, 5845.2401187845735, 5869.735861886183, 5881.323647780475, 6211.782587609412, 6273.184486016834, 6277.7175027123885, 6281.309056003836, 6356.682165891687, 6726.865462690767, 6729.024291477757, 6736.124303840518, 6821.931780682229, 6869.278725733826, 6613.933860661428, 6718.596884186964, 6813.216480104802, 6817.386435220854, 6893.241743408221, 6198.194234749499, 6330.778422755181, 6366.522510811707, 6370.012648039561, 6371.076193951897, 6907.447404207652, 6931.272216417204, 7001.264867188974, 7007.684654190573, 7014.0531028310525, 6606.075149479077, 6666.433353165035, 6698.12924319845, 6707.66461676924, 6752.3922846944015, 6612.768553100715, 6714.29499902513, 6718.630475323806, 6730.495212859055, 6837.931620683829, 6722.058911752359, 6786.423154031962, 6791.830204244933, 6805.013273075377, 6817.181938167352, 6696.799096027127, 6712.664366781642, 6757.763478278237, 6760.614074114893, 6843.418309443654, 5230.0, 5272.525472707474, 5276.5251127398715, 5280.973595132076, 5343.225232341367, 4513.616342610849, 4533.252013417749, 4540.77296135192, 4614.561616646413, 4678.555537223959, 5893.970530147321, 5916.763329466859, 5975.7609695612555, 5982.162497250389, 5999.310079340845, 6780.898286525706, 6797.286284940109, 6808.2510923798345, 6872.759453419107, 6877.968304754327, 5800.680962547016, 5870.765169393262, 5873.882522349614, 5928.67392293428, 5956.0, 5714.0, 5799.014167591519, 5802.506786923074, 5803.8549036274435, 5839.5036421904615, 6626.768063117768, 6680.0, 6714.429273511806, 6719.596824190564, 6720.9663951680905, 6833.45332373399, 6839.62382068991, 6900.068490753684, 6922.896156557656, 6924.792256232321, 6418.839529011625, 6542.051402546699, 6594.439472644879, 6669.333066693292, 6673.232578253563, 6600.2409722882485, 6615.470762338905, 6654.367835055662, 6677.799666010027, 6680.665966701743, 6787.524873258824, 6838.316168383122, 6863.38229559342, 6881.587104773529, 6898.344657257552, 6518.967405162944, 6532.477401807939, 6581.605103693793, 6628.5028622852515, 6636.0, 6390.137331460193, 6478.902816457663, 6538.378854008862, 6573.80278591643, 6636.435902948304, 6485.805425837232, 6586.242582103119, 6610.041543976193, 6614.90077648826, 6618.305077966744, 6563.0811686362995, 6585.868282634417, 6627.0, 6635.4359879410795, 6673.165854268216, 6186.0, 6302.936970630235, 6352.333005034405, 6412.166418365583, 6451.967740161269], "value": 6147.107166451158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.2206837299447, 855.2473823035727, 882.7616543533246, 1124.291696231374, 1136.3466007045952, 38812.41781373278, 40112.79943600278, 40222.99999999993, 40260.0, 40318.79840600797, 40507.59492405075, 40687.38968915468, 40856.0, 40911.38632920509, 40934.18131637365, 7473.514221575608, 7618.162002179756, 7618.923810761877, 7620.809479762995, 7625.199354067826, 6921.134858142732, 7128.180259270172, 7498.512596681198, 7500.474966752329, 7523.548587084765, 7479.102507699056, 7515.962420187891, 7530.736424225153, 7534.585597792119, 7536.698532058711, 7489.887651685229, 7514.173440921494, 7522.435817313696, 7530.322270995636, 7537.585432801194, 7421.0723659542555, 7425.888611670829, 7513.248675132498, 7522.13495448025, 7527.322540971284, 36386.45420318697, 36538.63461365379, 36605.63394366049, 36721.26557468862, 36732.265354692754, 3425.3491836550975, 3448.103493091789, 3456.654334566548, 3457.5159477673146, 3467.6185619581825, 30205.546916796266, 30240.546391804142, 30269.848650756827, 30276.54585181224, 30278.0, 5128.051310507568, 5129.358830146231, 5135.075686376451, 5170.638055336128, 5212.817551385683, 187630.0, 188366.0, 189361.0, 189528.0, 190540.0, 46321.76839115783, 46413.0, 46445.07109857851, 46463.53536464592, 46615.067698645835, 47339.0, 50467.24299135516, 51331.23003154956, 51492.48507514952, 51533.227001595005, 14840.10959342443, 14947.626309342353, 14975.0, 14990.925045374703, 15004.549863504113, 10595.629152979609, 11746.353950532632, 11947.761044779056, 11963.64109076729, 11980.520779168735, 11896.76206475883, 15017.774733379008, 15051.1721855299, 15069.17119558413, 15321.46374876874, 6085.695715214221, 6119.623084805972, 6161.983272760034, 6176.81469555914, 6179.3820617937845, 978.882534095913, 1005.2812239248972, 1005.9245556583139, 1011.726833754882, 1013.7313611892854, 21880.0, 21890.89054554717, 21980.78019219787, 21981.450463738216, 22022.90782375672, 1070.7430216747925, 1089.9972025736342, 1098.1050443888205, 1107.1087774341572, 1109.8446217529552, 11445.484953177127, 11609.432726581972, 11651.650450486499, 11702.180847340775, 11747.765044699057, 238478.0, 242088.0, 242161.0, 242428.0, 242468.0, 54479.0, 54910.17634735482, 55097.0, 55120.44879551233, 55246.44753552413, 1394.623451668044, 1431.6492459347526, 1450.4415799916897, 1458.6572155543438, 1460.9488667896785, 26701.466170290747, 26894.462110757286, 27161.59257611098, 27230.319242019108, 27493.587596185673, 35256.823715881255, 35394.8230258847, 35471.64528354684, 35494.46758298576, 35530.0, 210167.0, 210594.0, 210678.0, 211028.0, 211071.0, 32467.837660811543, 32727.836360818044, 32956.0, 35295.823520883256, 36345.636543634224, 43167.0, 44231.0, 44334.55665443304, 44467.55532444763, 44609.10781784411, 31853.522197166596, 32288.515672264464, 32888.67111328952, 33490.0, 33630.0, 32061.839690801397, 32277.35445291128, 32450.513242301855, 32520.83739581287, 32912.835435822664, 36142.0, 36270.45594316035, 36672.63327366692, 36690.44964325484, 36813.26373472569, 31219.84390078126, 31503.0, 31508.369832602762, 31896.36207275888, 33400.33199335951, 24332.270031899072, 24467.0, 24989.375265618506, 25060.12289569856, 25515.872420637777], "value": 17110.404834885056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8554518597759, 571.7198572699378, 572.301791813987, 582.1587805620878, 582.5805420097531, 21871.234506792265, 22622.095116195374, 22726.090956361746, 22733.658995115085, 22765.31704048877, 24805.50388992219, 25346.366340841487, 25472.74527254727, 25531.872340638318, 25539.489210215783, 6671.566348187353, 6833.282505336942, 6840.555363901355, 6843.110395648559, 6847.10987571615, 5981.342052374257, 6260.0, 6518.120053792748, 6537.64042977636, 6543.901841472381, 6489.091527186198, 6512.413882750551, 6514.120593719858, 6514.967425162868, 6518.478521718251, 6464.159659244268, 6492.870142597145, 6493.253275873264, 6494.928336824419, 6497.772577959772, 6035.849103772397, 6044.455998960115, 6048.334683184846, 6049.939500604982, 6055.515558755289, 28390.716092839015, 28974.565381519293, 29466.558001629994, 29696.406071878657, 29722.0, 1967.07547452697, 2015.2845739762467, 2016.4555569996166, 2018.6366454038268, 2018.7173795668618, 19222.327218547285, 19641.31255406054, 19841.9007904961, 19923.90038049815, 19973.600527989358, 2225.732912050564, 2253.267688001406, 2266.195500597281, 2277.9316620501413, 2278.475950531387, 128060.0, 130206.0, 130628.6937130626, 131287.3435632825, 131295.34352328177, 14532.854671453362, 15115.168665723271, 15137.621559460882, 15168.014079084824, 15218.239088045553, 22629.094836206696, 22650.66024009641, 22725.0, 22772.2029728962, 22856.771432285797, 9932.304738668225, 10016.599336026624, 10029.247806414549, 10157.695269141937, 10200.642977495752, 7871.685132594746, 9188.49463279526, 9243.537823108818, 9291.256699464027, 9382.24942004638, 8165.2243036911395, 9199.908000919904, 9381.0, 9407.43555386679, 9432.95283523578, 2713.9592906106423, 2730.494858451193, 2762.240383894405, 2789.693133755285, 2842.147355793295, 966.2801213096288, 992.1318846009741, 994.1003391930315, 998.610541888664, 1003.6336737090909, 20033.499162520762, 20327.390178294674, 20327.4918127048, 20339.186432542534, 20514.58970820605, 973.6251543155936, 1048.743057950807, 1077.6282182646974, 1079.0127033764174, 1081.297156848055, 10355.94822025885, 11405.372704501166, 13024.609261722164, 14046.85953140476, 14117.576472705836, 511719.0, 514133.0, 521240.0, 532543.0, 536312.0, 118007.0, 118548.0, 118943.40528297477, 120484.0, 120936.39531802284, 1215.155466950461, 1226.3868065967017, 1257.3964497041288, 1273.0642977411594, 1280.6542233596876, 21768.782312176674, 21862.672059918797, 22075.558488830455, 22140.33578992633, 22183.334499965025, 60112.39887601243, 60281.69859150676, 60441.395586043574, 61336.07995880154, 63293.68353158205, 76047.0, 77955.22044779707, 78240.60879695565, 80714.19285807067, 80799.59600202196, 20380.69428958537, 20869.582608348053, 20870.791292086884, 21226.0, 21380.679289810356, 22925.88537057371, 23117.422064448525, 23958.76041239565, 24027.399315017265, 24043.278701638978, 18436.26254949787, 18594.349197778014, 18696.719549207046, 18758.437246882615, 18768.155433005275, 16475.505734827973, 16719.582010449834, 16941.0, 17100.572485687957, 17215.827841721424, 18579.81420185835, 19418.417447476597, 19538.21847126156, 19578.902105489382, 19718.90140549288, 21054.2631007914, 21197.36407907765, 21409.357719268446, 21476.033578489318, 21483.248086316904, 16549.58626034359, 17612.82387176163, 17673.82326176722, 17880.55298617545, 17884.195211215785], "value": 12416.18275359155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.7143264198198, 1365.9453621855123, 1384.5500212430964, 1385.9653508662288, 1394.6861956059888, 14953.177575233358, 15113.848861511382, 15591.922040389782, 15596.220188990548, 15608.765868511982, 15751.133687647174, 16119.516414507583, 16142.0, 16149.192540372964, 16169.272382742776, 2807.354308509044, 2851.3014311493607, 2870.6698729646046, 2870.856457177143, 2872.5403935370346, 2687.153546632814, 2808.7331703488135, 2809.7752179825666, 2809.8595070246506, 2812.170409729135, 2721.0748345562506, 2792.246093554739, 2793.106206014076, 2794.2315863137696, 2794.3572978215025, 2701.7433343832304, 2773.791965602568, 2774.9861250693716, 2777.0141599732005, 2778.2082106599523, 2721.4285000149994, 2741.9040333588227, 2744.4785490756694, 2745.835249885013, 2749.408877091435, 14656.193909334983, 14951.925240373837, 15010.174440405774, 15027.624309392244, 15049.172295523742, 7676.769696909102, 7933.087694915101, 8017.639206235675, 8026.959865200637, 8036.276735093811, 4928.950710492921, 5064.670796398223, 5170.741462926839, 5192.662476938987, 5214.8696282592855, 1804.5578833185823, 1842.5762074722888, 1846.8430183434425, 1895.848332133426, 1906.256559941624, 26108.0, 26299.73700262992, 26448.07431739899, 26480.07319743819, 26480.205593832216, 6697.799066028027, 6827.419669328064, 6876.965615171992, 6883.139607549057, 6994.370506654323, 17088.0, 17204.31182752701, 17230.741538876926, 17257.309707611555, 17258.223379947933, 7594.620268986529, 7894.526328420313, 7910.090339611018, 7923.643436045391, 7938.841223175619, 5994.430529099728, 6055.970485017558, 7375.557466552024, 7403.7408690695565, 7441.479096463196, 5073.213651883964, 5085.898282034339, 5128.512731307954, 5144.562712169432, 5174.7930082796265, 1501.196859680066, 1537.408097882301, 1538.415402147177, 1553.184578096486, 1554.6579752454443, 926.2867591954292, 938.5401153434768, 947.6067432015774, 952.4285428742837, 970.2286682087757, 7780.066392032879, 7823.608819558999, 7839.3728501719725, 7861.213878612093, 7999.800004999922, 719.6833393306928, 721.2354903801987, 728.9198188199293, 730.9269073092648, 737.4063878577689, 5121.718305493159, 5325.174597937326, 5522.779088836482, 5625.46558076982, 5667.688277144714, 21807.781922180893, 22628.434289142573, 22679.433014174778, 22768.316950491513, 22769.772302276764, 21296.25463108784, 22140.2250921217, 22155.889220553792, 22360.888195559244, 22450.32649020532, 11214.831777523344, 11507.76984460306, 11521.942390288163, 11540.307581545134, 11543.595974140864, 8212.014558253048, 8275.917240827515, 8307.376946728898, 8350.123237060021, 8398.622062007102, 18519.814801851808, 18895.43313700591, 19202.519937001685, 19205.8079419204, 19234.615307693486, 18613.0, 19326.806731932502, 19467.61064778668, 19914.800851991295, 19929.800701992794, 11145.0, 11467.082633389477, 11559.537618495166, 11560.768784624091, 11583.0, 14021.29893505341, 14135.858641413866, 14281.357338919566, 14285.0, 14311.856881431053, 10985.780284394108, 11074.280171788809, 11203.831942520706, 11389.373584452935, 11538.653840384803, 10790.35257884498, 10799.460026998775, 10808.783824323313, 11019.614313498989, 11022.779544409228, 8584.399092063495, 8637.093105224112, 8650.610722517376, 8666.263367613823, 8668.393212475066, 6375.107484952203, 6383.6808159592765, 6460.0, 6484.0, 6660.866782664417, 6970.233274339717, 7020.473464490082, 7091.893621595577, 7282.308180722823, 7469.029026226774], "value": 6616.743928619525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.87471257473044, 503.90677724620934, 517.880887395899, 519.7453247908525, 521.7521677203329, 6089.0, 6192.133101365806, 6193.986954239873, 6202.8910170542, 6226.0, 6057.36397678243, 6085.4827339676185, 6094.390560943903, 6102.071005917162, 6142.87714245716, 5121.308623335858, 5122.282880396748, 5137.229415587673, 5140.357455318085, 5152.201408781645, 4847.1517484440255, 4889.364382630253, 5126.7436628168625, 5144.1254986652175, 5165.8450246492475, 4879.51204879511, 4912.778924948386, 4923.310736496894, 4943.480934501879, 4954.0, 4876.0, 4883.780229889663, 4909.159065350494, 4940.51784464661, 4971.900561988758, 4301.5698430157045, 4378.868633940987, 4379.43067401239, 4423.159599676052, 4471.396361491222, 5909.793157239519, 5953.196318496991, 5954.672493012926, 5954.689968206988, 6049.576529642927, 5553.333599968029, 5641.8589535261535, 5664.867026594657, 5677.290338707661, 5688.5733569982, 6510.18622672166, 6513.674316284214, 6521.543491955565, 6528.836779080513, 6548.214214294268, 4794.472608013116, 4795.904081918377, 4817.783199755984, 4823.662343635947, 4843.39457567804, 6434.967825160844, 6480.708368123445, 6614.570052946543, 6650.40390306323, 6681.966590167018, 4891.04624598207, 4904.975475122602, 4921.975390123026, 4925.802967881316, 4944.332515110414, 4966.354373931438, 5004.674696144812, 5022.547970682656, 5024.522670346311, 5063.291139240509, 5531.695756733418, 5602.974393827369, 5625.774969001194, 5629.155626655953, 5651.124075768263, 6412.775552855721, 6436.3587285241965, 6451.548391612542, 6466.773662921775, 6500.919705694132, 1717.668806674812, 1738.1309345327336, 1741.991290043567, 1750.4136114401563, 1755.6400937807718, 1142.7885841119419, 1186.4008675618757, 1192.9025296727032, 1209.975800484003, 1220.6033039262275, 5644.125160600113, 5664.518515926193, 5686.346070201897, 5691.430856914276, 5703.771849126071, 6484.870302593922, 6485.254195767453, 6532.183477065367, 6584.353911522119, 6588.397582954706, 5619.80330688424, 5635.295588051494, 5716.771329146871, 5718.370979192286, 5721.914171287434, 3438.5014172944784, 3438.5873695156242, 3453.447448408293, 3530.805805680712, 3532.5054492371087, 6423.907935650951, 6445.2587952386075, 6452.161219041588, 6462.48300135988, 6509.2839787623325, 6700.865982680319, 6745.426638735762, 6756.358145976223, 6845.452363810883, 6872.931270687229, 6396.424321810966, 6439.871202576016, 6452.451541619015, 6457.903131453126, 6478.967605161944, 6074.544409169418, 6536.182977127859, 6557.639329836905, 6599.307072757291, 6705.7929572677385, 6502.479801615954, 6569.343065693392, 6622.437092847162, 6623.668816559057, 6640.50196235294, 6334.809955701337, 6491.578047426902, 6510.414062734377, 6539.378759017885, 6540.037988603305, 4923.433805112458, 4940.2342636891335, 4959.776810043484, 4962.801487940586, 4965.503449655005, 6479.838004049937, 6612.23959244693, 6660.800175994728, 6757.222919364336, 6787.932120678927, 6323.683815809283, 6415.133956915756, 6432.35676432353, 6472.255690595642, 6484.837879053061, 6439.613623182624, 6474.935250647622, 6476.158099447231, 6488.448481879093, 6507.056476810931, 6375.394337537927, 6397.424231819158, 6409.0, 6443.96778016107, 6463.7737679181, 6347.90478142819, 6480.189976252968, 6500.382463666133, 6512.772052978123, 6532.5427220096035, 6272.466840318624, 6291.811245662638, 6322.81862757348, 6337.65142917144, 6369.617822930453], "value": 4995.301855902364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.4640496094903, 871.8343514732202, 902.2556390977443, 905.9501727404994, 908.4095338030276, 17668.29326826927, 17927.193276302565, 18126.456206313815, 18143.455696329132, 18253.726194107097, 20439.284625038126, 21830.45423864404, 21862.125514979383, 21862.23482178124, 21894.12423503062, 941.4821847983616, 974.2790335151972, 980.1619615228983, 980.186445250444, 981.3817295104075, 901.8241442918634, 991.1377101921339, 993.6174572789456, 993.7267251505857, 994.0, 967.1054274795821, 1016.2428990402124, 1023.8208313545138, 1027.984580231297, 1028.9434081125535, 1028.912542433894, 1029.3206483720708, 1029.3360782295415, 1029.7425643589104, 1031.2162756305224, 759.7644730133676, 759.8784194528849, 760.2473551184343, 760.4182800157884, 761.7524304601027, 16640.251188696537, 17326.39357622477, 18325.908370458063, 18538.165782539818, 18660.720089198538, 20220.79779202204, 20419.591608167753, 20728.58542829135, 21160.365189044198, 21164.894175529178, 15502.457413990456, 16015.599610009844, 16139.11234882081, 16176.595585110348, 16177.19114044293, 3699.3896007158787, 3730.6082861299715, 3732.234891847165, 3735.589085200626, 3739.326921154191, 128398.35800820935, 130750.3462482691, 131185.34407327996, 131831.0, 132867.99999999904, 15738.134402607966, 16076.43732469358, 16341.918290408472, 16352.509424717278, 16357.345706171858, 29524.261893452836, 29595.408091838042, 30205.848970755007, 30250.69749302479, 30345.24136896595, 7490.5131166474, 7841.921580784119, 7872.763817085496, 8021.679132834738, 8381.832363352822, 3900.395438707005, 4001.7198796084576, 4004.1791432756213, 4005.239004589119, 4032.475778148822, 5019.623528235397, 5052.166392545262, 5108.386993560722, 5121.8463446096675, 5126.846194614168, 1052.1582733813073, 1059.5338051257422, 1078.5254488025244, 1079.1043433949803, 1080.7784404197278, 619.1115748900343, 625.7872323410062, 634.2040738872686, 639.5906619763355, 653.2259272761793, 10593.788124237471, 10650.573977040987, 10701.143908487302, 12013.519459221709, 12347.444365003596, 598.6049207523014, 617.1914791622988, 620.9658468784261, 628.8710814283061, 638.7093872288191, 4903.754812259444, 4942.777575009133, 5080.974595127074, 5239.345081864767, 5290.444503327095, 111873.44063279631, 114555.0, 116226.41886790511, 118641.40679296548, 119239.40380298044, 95234.52382738181, 96222.0, 96666.0, 98382.0, 102085.48957255315, 82716.0, 83445.16554834374, 83966.0, 85007.0, 85945.57027214824, 9941.950290248502, 10021.949890250502, 10082.899171008195, 10365.792684146425, 10396.480175991019, 39472.2105557893, 40610.39084413677, 40900.79549602352, 41040.38439423471, 41399.0, 54060.18909716436, 54152.45847541474, 54485.45514544804, 55246.44753552574, 55517.72241138769, 13841.930790346387, 14237.430502779773, 14247.287635618384, 14297.857021429652, 14313.713725725636, 15076.321565529797, 15106.697866042397, 15159.09045457276, 15242.466513671969, 15342.15618141013, 13902.23537705436, 14190.503332383318, 14291.499797507038, 14376.640583985483, 14389.856101438852, 14365.497207597684, 14437.927810360881, 14593.1973741441, 14652.926735366254, 14665.853341466449, 14120.505782297982, 14208.0, 14211.076280041763, 14371.20958347301, 14371.85628143747, 9403.43579385239, 9430.10414010668, 9525.618975240914, 9695.321327507007, 9734.0, 9603.183729383081, 9621.134097931219, 9713.854292185482, 9794.804103918024, 10038.749031274276], "value": 8394.74165442886, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 112.0, 106.0, 107.0, 112.0, 114.0, 99.0, 108.0, 109.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 154.0, 177.0, 119.0, 145.0, 144.0, 116.0, 181.0, 119.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 162.0, 163.0, 165.0, 171.0, 167.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 172.0, 75.0, 74.0, 74.0, 75.0, 151.0, 75.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 131.0, 80.0, 79.0, 79.0, 120.0, 79.0, 78.0, 140.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 117.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 150.0, 149.0, 150.0, 150.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 54.0, 52.0, 52.0, 52.0, 57.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 74.0, 78.0, 75.0, 75.0, 76.0, 75.0, 74.0, 76.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 118.0, 117.0, 117.0, 132.0, 121.0, 126.0, 121.0, 122.0, 160.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 184.0, 170.0, 170.0, 169.0, 170.0, 170.0, 170.0, 170.0, 180.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 65.0, 66.0, 63.0, 65.0, 63.0, 66.0, 64.0, 67.0], "value": 65.3, "unit": "score"}]}]} 14:13:04 INFO - Return code: 0 14:13:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:13:04 INFO - # TBPL SUCCESS # 14:13:04 INFO - Running post-action listener: _package_coverage_data 14:13:04 INFO - Running post-action listener: _resource_record_post_action 14:13:04 INFO - [mozharness: 2017-08-31 21:13:04.290572Z] Finished run-tests step (success) 14:13:04 INFO - Running post-run listener: _resource_record_post_run 14:13:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389885952; Read time: 8; Write time: 244980 14:13:04 INFO - TinderboxPrint: CPU usage
13.1% 14:13:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:13:04 INFO - TinderboxPrint: I/O write bytes / time
389,885,952 / 244,980 14:13:04 INFO - TinderboxPrint: CPU idle
8,245.6 (86.9%) 14:13:04 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 14:13:04 INFO - TinderboxPrint: Swap in / out
0 / 0 14:13:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106573824; Read time: 0; Write time: 108988 14:13:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:13:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283312128; Read time: 8; Write time: 135992 14:13:04 INFO - Running post-run listener: _upload_blobber_files 14:13:04 INFO - Blob upload gear active. 14:13:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:13:04 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 14:13:04 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'] 14:13:04 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 14:13:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:13:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:13:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:13:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:06 INFO - (blobuploader) - INFO - Done attempting. 14:13:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:13:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:13 INFO - (blobuploader) - INFO - Done attempting. 14:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:13:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:14 INFO - (blobuploader) - INFO - Done attempting. 14:13:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:13:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:13:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:15 INFO - (blobuploader) - INFO - Done attempting. 14:13:15 INFO - (blobuploader) - INFO - Iteration through files over. 14:13:15 INFO - Return code: 0 14:13:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:13:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:13:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a9193d39e471ec712aed1c9a42b4e8a240ad322b7cbc8fc98a0f4031af6548faeb8b186ae608989855311811cd0f4746b71b35f805bf8648eb2801c43d0f33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638527787d5bd961580ee443620988b9180ebfa42bb7c6dfe5e299046c6cd79b52eccb8f78d93d0ed76990fb3b579735e739afce045053b9d04d804bc592ae4d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adf130a573f19643a082b57a7414ac30df59670a197c98b69115bb22ef893606e4ae0f6456fe9fed9a90f2eb7bca8825578fc6148be3d371c907e6b35a44aee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ecd9e805bbfd84c8afae96883de3a386cd0a5c8647a30c3279e0dd6c73aa86a83190de2dbe3b4d07a6e8f80a91e53b9e085d9dd96e564cb6f53165a489082fb"} 14:13:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:13:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:13:15 INFO - Contents: 14:13:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a9193d39e471ec712aed1c9a42b4e8a240ad322b7cbc8fc98a0f4031af6548faeb8b186ae608989855311811cd0f4746b71b35f805bf8648eb2801c43d0f33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638527787d5bd961580ee443620988b9180ebfa42bb7c6dfe5e299046c6cd79b52eccb8f78d93d0ed76990fb3b579735e739afce045053b9d04d804bc592ae4d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adf130a573f19643a082b57a7414ac30df59670a197c98b69115bb22ef893606e4ae0f6456fe9fed9a90f2eb7bca8825578fc6148be3d371c907e6b35a44aee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ecd9e805bbfd84c8afae96883de3a386cd0a5c8647a30c3279e0dd6c73aa86a83190de2dbe3b4d07a6e8f80a91e53b9e085d9dd96e564cb6f53165a489082fb"} 14:13:15 INFO - Running post-run listener: copy_logs_to_upload_dir 14:13:15 INFO - Copying logs to upload dir... 14:13:15 INFO - mkdir: /builds/slave/test/build/upload/logs 14:13:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.270899 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-31 14:13:15.085878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:15.089942) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a9193d39e471ec712aed1c9a42b4e8a240ad322b7cbc8fc98a0f4031af6548faeb8b186ae608989855311811cd0f4746b71b35f805bf8648eb2801c43d0f33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638527787d5bd961580ee443620988b9180ebfa42bb7c6dfe5e299046c6cd79b52eccb8f78d93d0ed76990fb3b579735e739afce045053b9d04d804bc592ae4d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adf130a573f19643a082b57a7414ac30df59670a197c98b69115bb22ef893606e4ae0f6456fe9fed9a90f2eb7bca8825578fc6148be3d371c907e6b35a44aee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ecd9e805bbfd84c8afae96883de3a386cd0a5c8647a30c3279e0dd6c73aa86a83190de2dbe3b4d07a6e8f80a91e53b9e085d9dd96e564cb6f53165a489082fb"} build_url:https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a9193d39e471ec712aed1c9a42b4e8a240ad322b7cbc8fc98a0f4031af6548faeb8b186ae608989855311811cd0f4746b71b35f805bf8648eb2801c43d0f33", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638527787d5bd961580ee443620988b9180ebfa42bb7c6dfe5e299046c6cd79b52eccb8f78d93d0ed76990fb3b579735e739afce045053b9d04d804bc592ae4d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adf130a573f19643a082b57a7414ac30df59670a197c98b69115bb22ef893606e4ae0f6456fe9fed9a90f2eb7bca8825578fc6148be3d371c907e6b35a44aee9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ecd9e805bbfd84c8afae96883de3a386cd0a5c8647a30c3279e0dd6c73aa86a83190de2dbe3b4d07a6e8f80a91e53b9e085d9dd96e564cb6f53165a489082fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:15.117214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:15.117596) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1504208882.925178-1471365233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:15.199867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 14:13:15.200260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 14:13:15.200622) ========= ========= Total master_lag: 0.22 =========