builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1505654126.09 results: success (0) revision: 877d536658e644bd0d1662d608cc2ca3a9fa8d9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.089597) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.090154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.090452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.339641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.339903) ========= 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=9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 06:15:26-- 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% 45.8M=0s 2017-09-17 06:15:26 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085696 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.494891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.498333) ========= 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=9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014336 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:26.573831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-17 06:15:26.577178) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 877d536658e644bd0d1662d608cc2ca3a9fa8d9f --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 877d536658e644bd0d1662d608cc2ca3a9fa8d9f --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=9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 06:15:26,681 truncating revision to first 12 chars 2017-09-17 06:15:26,681 Setting DEBUG logging. 2017-09-17 06:15:26,681 attempt 1/10 2017-09-17 06:15:26,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/877d536658e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 06:15:27,093 attempt 1/10 2017-09-17 06:15:27,836 current task status: no status available at this point. state: STARTED 2017-09-17 06:15:27,837 sleeping for 11.00s (attempt 1/10) 2017-09-17 06:15:38,848 attempt 2/10 2017-09-17 06:15:39,155 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-17 06:15:39,332 unpacking tar archive at: mozilla-central-877d536658e6/testing/mozharness/ program finished with exit code 0 elapsedTime=12.954317 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-17 06:15:39.566791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:39.567256) ========= script_repo_revision: 877d536658e644bd0d1662d608cc2ca3a9fa8d9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:39.567773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:39.568178) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 06:15:39.585363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-17 06:15:39.585825) ========= /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=9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:15:39 INFO - MultiFileLogger online at 20170917 06:15:39 in /builds/slave/test 06:15:39 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 06:15:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:15:39 INFO - {'append_to_log': False, 06:15:39 INFO - 'base_work_dir': '/builds/slave/test', 06:15:39 INFO - 'blob_upload_branch': 'Firefox', 06:15:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:15:39 INFO - 'branch': 'Firefox', 06:15:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:15:39 INFO - 'code_coverage': False, 06:15:39 INFO - 'config_files': ('talos/linux_config.py',), 06:15:39 INFO - 'default_actions': ('clobber', 06:15:39 INFO - 'read-buildbot-config', 06:15:39 INFO - 'download-and-extract', 06:15:39 INFO - 'populate-webroot', 06:15:39 INFO - 'create-virtualenv', 06:15:39 INFO - 'install', 06:15:39 INFO - 'setup-mitmproxy', 06:15:39 INFO - 'run-tests'), 06:15:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:15:39 INFO - 'disable_ccov_upload': False, 06:15:39 INFO - 'disable_stylo': False, 06:15:39 INFO - 'download_minidump_stackwalk': True, 06:15:39 INFO - 'download_symbols': 'ondemand', 06:15:39 INFO - 'enable_stylo': False, 06:15:39 INFO - 'enable_webrender': False, 06:15:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:15:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:15:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:15:39 INFO - 'gecko_profile': False, 06:15:39 INFO - 'gecko_profile_interval': 0, 06:15:39 INFO - 'installer_path': 'installer.exe', 06:15:39 INFO - 'log_level': 'info', 06:15:39 INFO - 'log_name': 'talos', 06:15:39 INFO - 'log_to_console': True, 06:15:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:15:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:15:39 INFO - 'opt_config_files': (), 06:15:39 INFO - 'pip_index': False, 06:15:39 INFO - 'suite': 'dromaeojs-e10s', 06:15:39 INFO - 'system_bits': '32', 06:15:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:15:39 INFO - 'title': 'talos-linux64-ix-076', 06:15:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:15:39 INFO - 'use_talos_json': True, 06:15:39 INFO - 'verify': 'False', 06:15:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:15:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:15:39 INFO - 'work_dir': 'build'} 06:15:39 INFO - [mozharness: 2017-09-17 13:15:39.823962Z] Running clobber step. 06:15:39 INFO - Running pre-action listener: _resource_record_pre_action 06:15:39 INFO - Running main action method: clobber 06:15:39 INFO - rmtree: /builds/slave/test/build 06:15:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:15:40 INFO - Running post-action listener: _resource_record_post_action 06:15:40 INFO - [mozharness: 2017-09-17 13:15:40.822179Z] Finished clobber step (success) 06:15:40 INFO - [mozharness: 2017-09-17 13:15:40.822275Z] Running read-buildbot-config step. 06:15:40 INFO - Running pre-action listener: _resource_record_pre_action 06:15:40 INFO - Running main action method: read_buildbot_config 06:15:40 INFO - Using buildbot properties: 06:15:40 INFO - { 06:15:40 INFO - "project": "", 06:15:40 INFO - "product": "firefox", 06:15:40 INFO - "who": "archaeopteryx@coole-files.de", 06:15:40 INFO - "installer_path": "public/build/target.tar.bz2", 06:15:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 06:15:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:15:40 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 06:15:40 INFO - "stage_platform": "linux64-qr", 06:15:40 INFO - "basedir": "/builds/slave/test", 06:15:40 INFO - "buildnumber": 69, 06:15:40 INFO - "platform": "ubuntu64_hw_qr", 06:15:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:15:40 INFO - "slavebuilddir": "test", 06:15:40 INFO - "taskId": "UanTdQsCQDasQf2Ey4arCg", 06:15:40 INFO - "branch": "mozilla-central", 06:15:40 INFO - "script_repo_revision": "production", 06:15:40 INFO - "revision": "877d536658e644bd0d1662d608cc2ca3a9fa8d9f", 06:15:40 INFO - "slavename": "talos-linux64-ix-076", 06:15:40 INFO - "repo_path": "mozilla-central" 06:15:40 INFO - } 06:15:40 INFO - Finding installer, test and symbols from parent task. 06:15:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UanTdQsCQDasQf2Ey4arCg'}, attempt #1 06:15:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UanTdQsCQDasQf2Ey4arCg'}, attempt #1 06:15:41 INFO - Task dependencies: Wjb9bWClSh6PQEiCFFxuzg 06:15:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg'}, attempt #1 06:15:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2 06:15:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.test_packages.json 06:15:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.crashreporter-symbols.zip 06:15:42 INFO - Running post-action listener: _resource_record_post_action 06:15:42 INFO - [mozharness: 2017-09-17 13:15:42.179554Z] Finished read-buildbot-config step (success) 06:15:42 INFO - [mozharness: 2017-09-17 13:15:42.179767Z] Running download-and-extract step. 06:15:42 INFO - Running pre-action listener: _resource_record_pre_action 06:15:42 INFO - Running main action method: download_and_extract 06:15:42 INFO - mkdir: /builds/slave/test/build/tests 06:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:42 INFO - trying https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.test_packages.json 06:15:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:15:42 INFO - Downloaded 989 bytes. 06:15:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:15:42 INFO - Using the following test package requirements: 06:15:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:15:42 INFO - u'common': [u'target.common.tests.zip'], 06:15:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:15:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:15:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:15:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:15:42 INFO - u'mozbase': [u'target.common.tests.zip'], 06:15:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:15:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:15:42 INFO - u'web-platform': [u'target.common.tests.zip', 06:15:42 INFO - u'target.web-platform.tests.tar.gz'], 06:15:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:15:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 06:15:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.common.tests.zip 06:15:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.common.tests.zip into memory 06:15:43 INFO - Content-Length response header: 54731270 06:15:43 INFO - Bytes received: 54731270 06:15:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.talos.tests.zip 06:15:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:15:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.talos.tests.zip into memory 06:15:55 INFO - Content-Length response header: 14508748 06:15:55 INFO - Bytes received: 14508748 06:15: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')]} 06:15:55 INFO - trying https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2 06:15:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:15:57 INFO - Downloaded 61376949 bytes. 06:15:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2 06:15:57 INFO - mkdir: /builds/slave/test/properties 06:15:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:57 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:57 INFO - Contents: 06:15:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2 06:15:57 INFO - Running post-action listener: _resource_record_post_action 06:15:57 INFO - Running post-action listener: find_tests_for_verification 06:15:57 INFO - Running post-action listener: set_extra_try_arguments 06:15:57 INFO - [mozharness: 2017-09-17 13:15:57.586820Z] Finished download-and-extract step (success) 06:15:57 INFO - [mozharness: 2017-09-17 13:15:57.586944Z] Running populate-webroot step. 06:15:57 INFO - Running pre-action listener: _resource_record_pre_action 06:15:57 INFO - Running main action method: populate_webroot 06:15:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['tresize', 06:15:57 INFO - 'tcanvasmark']}, 06:15:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['dromaeo_css', 06:15:57 INFO - 'kraken']}, 06:15:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'tests': ['damp', 'tps']}, 06:15:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['damp', 'tps']}, 06:15:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['dromaeo_dom']}, 06:15:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:15:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['basic_compositor_video', 06:15:57 INFO - 'glvideo']}, 06:15:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:15:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['ts_paint_webext', 06:15:57 INFO - 'tp5o_webext']}, 06:15:57 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:57 INFO - 'ts_paint', 06:15:57 INFO - 'tpaint', 06:15:57 INFO - 'sessionrestore', 06:15:57 INFO - 'sessionrestore_many_windows', 06:15:57 INFO - 'sessionrestore_no_auto_restore', 06:15:57 INFO - 'tabpaint']}, 06:15:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['a11yr', 06:15:57 INFO - 'ts_paint', 06:15:57 INFO - 'tpaint', 06:15:57 INFO - 'sessionrestore', 06:15:57 INFO - 'sessionrestore_many_windows', 06:15:57 INFO - 'sessionrestore_no_auto_restore', 06:15:57 INFO - 'tabpaint']}, 06:15:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:15:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 06:15:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['perf_reftest_singletons']}, 06:15:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['bloom_basic']}, 06:15:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:57 INFO - 'tsvgr_opacity', 06:15:57 INFO - 'tart', 06:15:57 INFO - 'tscrollx', 06:15:57 INFO - 'tsvg_static']}, 06:15:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['tsvgx', 06:15:57 INFO - 'tsvgr_opacity', 06:15:57 INFO - 'tart', 06:15:57 INFO - 'tscrollx', 06:15:57 INFO - 'tsvg_static']}, 06:15:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:15:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'talos_options': ['--disable-stylo'], 06:15:57 INFO - 'tests': ['tp5o']}, 06:15:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:15:57 INFO - 'talos_options': ['--mitmproxy', 06:15:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:15:57 INFO - '--firstNonBlankPaint'], 06:15:57 INFO - 'tests': ['tp6_google', 06:15:57 INFO - 'tp6_youtube', 06:15:57 INFO - 'tp6_amazon', 06:15:57 INFO - 'tp6_facebook']}, 06:15:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:15:57 INFO - 'talos_options': ['--disable-stylo', 06:15:57 INFO - '--mitmproxy', 06:15:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:15:57 INFO - '--firstNonBlankPaint'], 06:15:57 INFO - 'tests': ['tp6_google', 06:15:57 INFO - 'tp6_youtube', 06:15:57 INFO - 'tp6_amazon', 06:15:57 INFO - 'tp6_facebook']}, 06:15:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:15:57 INFO - 'talos_options': ['--stylo-threads=1', 06:15:57 INFO - '--mitmproxy', 06:15:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:15:57 INFO - '--firstNonBlankPaint'], 06:15:57 INFO - 'tests': ['tp6_google', 06:15:57 INFO - 'tp6_youtube', 06:15:57 INFO - 'tp6_amazon', 06:15:57 INFO - 'tp6_facebook']}, 06:15:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'talos_options': ['--xperf_path', 06:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:57 INFO - 'tests': ['tp5n']}, 06:15:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:15:57 INFO - 'talos_options': ['--disable-stylo', 06:15:57 INFO - '--xperf_path', 06:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:57 INFO - 'tests': ['tp5n']}}} 06:15:57 INFO - Running post-action listener: _resource_record_post_action 06:15:57 INFO - [mozharness: 2017-09-17 13:15:57.603623Z] Finished populate-webroot step (success) 06:15:57 INFO - [mozharness: 2017-09-17 13:15:57.603712Z] Running create-virtualenv step. 06:15:57 INFO - Running pre-action listener: _resource_record_pre_action 06:15:57 INFO - Running main action method: create_virtualenv 06:15:57 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:15:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:15:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:15:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:58 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:58 INFO - Installing pip...............done. 06:15:58 INFO - Return code: 0 06:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:15:58 INFO - Reading from file tmpfile_stdout 06:15:58 INFO - Output received: 06:15:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:15:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15: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')]} 06:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:15: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', 'pip>=1.5'] in /builds/slave/test/build 06:15: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 pip>=1.5 06:15:58 INFO - Using env: {'DISPLAY': ':0', 06:15:58 INFO - 'HOME': '/home/cltbld', 06:15:58 INFO - 'LANG': 'en_US.UTF-8', 06:15:58 INFO - 'LANGUAGE': 'en_US:en', 06:15:58 INFO - 'LOGNAME': 'cltbld', 06:15:58 INFO - 'MAIL': '/var/mail/cltbld', 06:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:58 INFO - 'MOZ_NO_REMOTE': '1', 06:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:58 INFO - 'NO_EM_RESTART': '1', 06:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:58 INFO - 'PWD': '/builds/slave/test', 06:15:58 INFO - 'SHELL': '/bin/bash', 06:15:58 INFO - 'SHLVL': '1', 06:15:58 INFO - 'TERM': 'linux', 06:15:58 INFO - 'TMOUT': '86400', 06:15:58 INFO - 'USER': 'cltbld', 06:15:58 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:58 INFO - '_': '/tools/buildbot/bin/python'} 06:15:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:15:59 INFO - Downloading/unpacking pip>=1.5 06:15:59 INFO - Running setup.py egg_info for package pip 06:15:59 INFO - warning: no files found matching 'pip/cacert.pem' 06:15:59 INFO - warning: no files found matching '*.html' under directory 'docs' 06:15:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:15:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:15:59 INFO - Installing collected packages: pip 06:15:59 INFO - Found existing installation: pip 1.1 06:15:59 INFO - Uninstalling pip: 06:15:59 INFO - Successfully uninstalled pip 06:15:59 INFO - Running setup.py install for pip 06:15:59 INFO - warning: no files found matching 'pip/cacert.pem' 06:15:59 INFO - warning: no files found matching '*.html' under directory 'docs' 06:15:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:15:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:15:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:15:59 INFO - Successfully installed pip 06:15:59 INFO - Cleaning up... 06:15:59 INFO - Return code: 0 06:15:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:59 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')]} 06:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:59 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')]} 06:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:59 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:15:59 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 06:15:59 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 06:15:59 INFO - Using env: {'DISPLAY': ':0', 06:15:59 INFO - 'HOME': '/home/cltbld', 06:15:59 INFO - 'LANG': 'en_US.UTF-8', 06:15:59 INFO - 'LANGUAGE': 'en_US:en', 06:15:59 INFO - 'LOGNAME': 'cltbld', 06:15:59 INFO - 'MAIL': '/var/mail/cltbld', 06:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:59 INFO - 'MOZ_NO_REMOTE': '1', 06:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:59 INFO - 'NO_EM_RESTART': '1', 06:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:59 INFO - 'PWD': '/builds/slave/test', 06:15:59 INFO - 'SHELL': '/bin/bash', 06:15:59 INFO - 'SHLVL': '1', 06:15:59 INFO - 'TERM': 'linux', 06:15:59 INFO - 'TMOUT': '86400', 06:15:59 INFO - 'USER': 'cltbld', 06:15:59 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:59 INFO - '_': '/tools/buildbot/bin/python'} 06:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:00 INFO - Downloading/unpacking psutil>=3.1.1 06:16: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 06:16: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 06:16: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 06:16: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 06:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:16:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:01 INFO - Installing collected packages: psutil 06:16:01 INFO - Running setup.py install for psutil 06:16:01 INFO - building 'psutil._psutil_linux' extension 06:16:01 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 06:16:01 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 06:16:01 INFO - building 'psutil._psutil_posix' extension 06:16:01 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 06:16:01 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 06:16:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:01 INFO - Successfully installed psutil 06:16:01 INFO - Cleaning up... 06:16:02 INFO - Return code: 0 06:16:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:16: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')]} 06:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16: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')]} 06:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:16: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 mozsystemmonitor==0.3 06:16:02 INFO - Using env: {'DISPLAY': ':0', 06:16:02 INFO - 'HOME': '/home/cltbld', 06:16:02 INFO - 'LANG': 'en_US.UTF-8', 06:16:02 INFO - 'LANGUAGE': 'en_US:en', 06:16:02 INFO - 'LOGNAME': 'cltbld', 06:16:02 INFO - 'MAIL': '/var/mail/cltbld', 06:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:02 INFO - 'MOZ_NO_REMOTE': '1', 06:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:02 INFO - 'NO_EM_RESTART': '1', 06:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:02 INFO - 'PWD': '/builds/slave/test', 06:16:02 INFO - 'SHELL': '/bin/bash', 06:16:02 INFO - 'SHLVL': '1', 06:16:02 INFO - 'TERM': 'linux', 06:16:02 INFO - 'TMOUT': '86400', 06:16:02 INFO - 'USER': 'cltbld', 06:16:02 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:02 INFO - '_': '/tools/buildbot/bin/python'} 06:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:16: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 06:16: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 06:16: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 06:16: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 06:16:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:16:04 INFO - Installing collected packages: mozsystemmonitor 06:16:04 INFO - Running setup.py install for mozsystemmonitor 06:16:04 INFO - Successfully installed mozsystemmonitor 06:16:04 INFO - Cleaning up... 06:16:04 INFO - Return code: 0 06:16:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:16: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')]} 06:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16: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')]} 06:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:04 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:04 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 06:16:04 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 06:16:04 INFO - Using env: {'DISPLAY': ':0', 06:16:04 INFO - 'HOME': '/home/cltbld', 06:16:04 INFO - 'LANG': 'en_US.UTF-8', 06:16:04 INFO - 'LANGUAGE': 'en_US:en', 06:16:04 INFO - 'LOGNAME': 'cltbld', 06:16:04 INFO - 'MAIL': '/var/mail/cltbld', 06:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:04 INFO - 'MOZ_NO_REMOTE': '1', 06:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:04 INFO - 'NO_EM_RESTART': '1', 06:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:04 INFO - 'PWD': '/builds/slave/test', 06:16:04 INFO - 'SHELL': '/bin/bash', 06:16:04 INFO - 'SHLVL': '1', 06:16:04 INFO - 'TERM': 'linux', 06:16:04 INFO - 'TMOUT': '86400', 06:16:04 INFO - 'USER': 'cltbld', 06:16:04 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:04 INFO - '_': '/tools/buildbot/bin/python'} 06:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:04 INFO - Downloading/unpacking jsonschema==2.5.1 06:16: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 06:16: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 06:16: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 06:16: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 06:16:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:16:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:16:05 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 06:16:05 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 06:16:05 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 06:16:05 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 06:16:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:16:05 INFO - warning: no files found matching '*.txt' 06:16:05 INFO - no previously-included directories found matching 'build' 06:16:05 INFO - no previously-included directories found matching 'dist' 06:16:05 INFO - no previously-included directories found matching '.git*' 06:16:05 INFO - Installing collected packages: jsonschema, functools32 06:16:05 INFO - Running setup.py install for functools32 06:16:05 INFO - warning: no files found matching '*.txt' 06:16:05 INFO - no previously-included directories found matching 'build' 06:16:05 INFO - no previously-included directories found matching 'dist' 06:16:05 INFO - no previously-included directories found matching '.git*' 06:16:05 INFO - Successfully installed jsonschema functools32 06:16:05 INFO - Cleaning up... 06:16:05 INFO - Return code: 0 06:16:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:16:05 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')]} 06:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:05 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')]} 06:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:05 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:05 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 06:16:05 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 06:16:05 INFO - Using env: {'DISPLAY': ':0', 06:16:05 INFO - 'HOME': '/home/cltbld', 06:16:05 INFO - 'LANG': 'en_US.UTF-8', 06:16:05 INFO - 'LANGUAGE': 'en_US:en', 06:16:05 INFO - 'LOGNAME': 'cltbld', 06:16:05 INFO - 'MAIL': '/var/mail/cltbld', 06:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:05 INFO - 'MOZ_NO_REMOTE': '1', 06:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:05 INFO - 'NO_EM_RESTART': '1', 06:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:05 INFO - 'PWD': '/builds/slave/test', 06:16:05 INFO - 'SHELL': '/bin/bash', 06:16:05 INFO - 'SHLVL': '1', 06:16:05 INFO - 'TERM': 'linux', 06:16:05 INFO - 'TMOUT': '86400', 06:16:05 INFO - 'USER': 'cltbld', 06:16:05 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:05 INFO - '_': '/tools/buildbot/bin/python'} 06:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:16:06 INFO - Cleaning up... 06:16:06 INFO - Return code: 0 06:16:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:06 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:06 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 06:16:06 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 06:16:06 INFO - Using env: {'DISPLAY': ':0', 06:16:06 INFO - 'HOME': '/home/cltbld', 06:16:06 INFO - 'LANG': 'en_US.UTF-8', 06:16:06 INFO - 'LANGUAGE': 'en_US:en', 06:16:06 INFO - 'LOGNAME': 'cltbld', 06:16:06 INFO - 'MAIL': '/var/mail/cltbld', 06:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:06 INFO - 'MOZ_NO_REMOTE': '1', 06:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:06 INFO - 'NO_EM_RESTART': '1', 06:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:06 INFO - 'PWD': '/builds/slave/test', 06:16:06 INFO - 'SHELL': '/bin/bash', 06:16:06 INFO - 'SHLVL': '1', 06:16:06 INFO - 'TERM': 'linux', 06:16:06 INFO - 'TMOUT': '86400', 06:16:06 INFO - 'USER': 'cltbld', 06:16:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:06 INFO - '_': '/tools/buildbot/bin/python'} 06:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:06 INFO - Downloading/unpacking blobuploader==1.2.4 06:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:07 INFO - Downloading blobuploader-1.2.4.tar.gz 06:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:16:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:16:07 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 06:16:07 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 06:16:07 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 06:16:07 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 06:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:16:07 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 06:16:07 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 06:16:07 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 06:16:07 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 06:16:07 INFO - Downloading docopt-0.6.1.tar.gz 06:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 06:16:07 INFO - Running setup.py install for blobuploader 06:16:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:16:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:16:08 INFO - Running setup.py install for requests 06:16:08 INFO - Running setup.py install for docopt 06:16:08 INFO - Successfully installed blobuploader requests docopt 06:16:08 INFO - Cleaning up... 06:16:08 INFO - Return code: 0 06:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16: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')]} 06:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16: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')]} 06:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:08 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:08 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 06:16:08 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 06:16:08 INFO - Using env: {'DISPLAY': ':0', 06:16:08 INFO - 'HOME': '/home/cltbld', 06:16:08 INFO - 'LANG': 'en_US.UTF-8', 06:16:08 INFO - 'LANGUAGE': 'en_US:en', 06:16:08 INFO - 'LOGNAME': 'cltbld', 06:16:08 INFO - 'MAIL': '/var/mail/cltbld', 06:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:08 INFO - 'MOZ_NO_REMOTE': '1', 06:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:08 INFO - 'NO_EM_RESTART': '1', 06:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:08 INFO - 'PWD': '/builds/slave/test', 06:16:08 INFO - 'SHELL': '/bin/bash', 06:16:08 INFO - 'SHLVL': '1', 06:16:08 INFO - 'TERM': 'linux', 06:16:08 INFO - 'TMOUT': '86400', 06:16:08 INFO - 'USER': 'cltbld', 06:16:08 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:08 INFO - '_': '/tools/buildbot/bin/python'} 06:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:08 INFO - Running setup.py (path:/tmp/pip-CBnieZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:08 INFO - Running setup.py (path:/tmp/pip-kqsUWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:08 INFO - Running setup.py (path:/tmp/pip-wTsIkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:09 INFO - Running setup.py (path:/tmp/pip-ujEnjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:09 INFO - Running setup.py (path:/tmp/pip-yckc9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:09 INFO - Running setup.py (path:/tmp/pip-Hty54D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:09 INFO - Running setup.py (path:/tmp/pip-Zc7svE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:09 INFO - Running setup.py (path:/tmp/pip-6Ehvyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:09 INFO - Running setup.py (path:/tmp/pip-nUNBV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:09 INFO - Running setup.py (path:/tmp/pip-3vbnXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:09 INFO - Running setup.py (path:/tmp/pip-S8z6Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:09 INFO - Running setup.py (path:/tmp/pip-nNmzFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:09 INFO - Running setup.py (path:/tmp/pip-BkM3yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:09 INFO - Running setup.py (path:/tmp/pip-4XLiJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:09 INFO - Running setup.py (path:/tmp/pip-GAGLiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:09 INFO - Running setup.py (path:/tmp/pip-0utVLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:09 INFO - Running setup.py (path:/tmp/pip-Pes1Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:16:09 INFO - Running setup.py install for manifestparser 06:16:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Running setup.py install for mozcrash 06:16:10 INFO - Running setup.py install for mozdebug 06:16:10 INFO - Running setup.py install for mozdevice 06:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Running setup.py install for mozfile 06:16:10 INFO - Running setup.py install for mozhttpd 06:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Running setup.py install for mozinfo 06:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Running setup.py install for mozInstall 06:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:16:10 INFO - Running setup.py install for mozleak 06:16:10 INFO - Running setup.py install for mozlog 06:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Running setup.py install for moznetwork 06:16:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Running setup.py install for mozprocess 06:16:11 INFO - Running setup.py install for mozprofile 06:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Running setup.py install for mozrunner 06:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Running setup.py install for mozscreenshot 06:16:11 INFO - Running setup.py install for moztest 06:16:11 INFO - Running setup.py install for mozversion 06:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:16:11 INFO - Cleaning up... 06:16:11 INFO - Return code: 0 06:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:11 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:11 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 06:16:11 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 06:16:11 INFO - Using env: {'DISPLAY': ':0', 06:16:11 INFO - 'HOME': '/home/cltbld', 06:16:11 INFO - 'LANG': 'en_US.UTF-8', 06:16:11 INFO - 'LANGUAGE': 'en_US:en', 06:16:11 INFO - 'LOGNAME': 'cltbld', 06:16:11 INFO - 'MAIL': '/var/mail/cltbld', 06:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:11 INFO - 'MOZ_NO_REMOTE': '1', 06:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:11 INFO - 'NO_EM_RESTART': '1', 06:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:11 INFO - 'PWD': '/builds/slave/test', 06:16:11 INFO - 'SHELL': '/bin/bash', 06:16:11 INFO - 'SHLVL': '1', 06:16:11 INFO - 'TERM': 'linux', 06:16:11 INFO - 'TMOUT': '86400', 06:16:11 INFO - 'USER': 'cltbld', 06:16:11 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:11 INFO - '_': '/tools/buildbot/bin/python'} 06:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:11 INFO - Running setup.py (path:/tmp/pip-R62r4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:12 INFO - Running setup.py (path:/tmp/pip-gb2xmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:12 INFO - Running setup.py (path:/tmp/pip-Ixl11Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:12 INFO - Running setup.py (path:/tmp/pip-skkgoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:12 INFO - Running setup.py (path:/tmp/pip-kwOLa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:12 INFO - Running setup.py (path:/tmp/pip-ORZHYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:12 INFO - Running setup.py (path:/tmp/pip-9YbUkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:12 INFO - Running setup.py (path:/tmp/pip-0PqJII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:12 INFO - Running setup.py (path:/tmp/pip-ssFtpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:12 INFO - Running setup.py (path:/tmp/pip-oDxSU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:12 INFO - Running setup.py (path:/tmp/pip-OqCbS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:12 INFO - Running setup.py (path:/tmp/pip-T8rvHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:12 INFO - Running setup.py (path:/tmp/pip-d7S7Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:12 INFO - Running setup.py (path:/tmp/pip-l92tiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:12 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)) 06:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:12 INFO - Running setup.py (path:/tmp/pip-N1k3RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:13 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)) 06:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:13 INFO - Running setup.py (path:/tmp/pip-vu67M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:13 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)) 06:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:13 INFO - Running setup.py (path:/tmp/pip-vjNP3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:13 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)) 06:16:13 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)) 06:16:13 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)) 06:16:13 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)) 06:16:13 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)) 06:16:13 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)) 06:16:13 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)) 06:16:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:13 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 06:16:13 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 06:16:13 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 06:16:13 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 06:16:14 INFO - Downloading blessings-1.6.tar.gz 06:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:16:14 INFO - Installing collected packages: blessings 06:16:14 INFO - Running setup.py install for blessings 06:16:14 INFO - Successfully installed blessings 06:16:14 INFO - Cleaning up... 06:16:14 INFO - Return code: 0 06:16:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:14 INFO - Reading from file tmpfile_stdout 06:16:14 INFO - Current package versions: 06:16:14 INFO - argparse == 1.2.1 06:16:14 INFO - blessings == 1.6 06:16:14 INFO - blobuploader == 1.2.4 06:16:14 INFO - docopt == 0.6.1 06:16:14 INFO - functools32 == 3.2.3-2 06:16:14 INFO - jsonschema == 2.5.1 06:16:14 INFO - manifestparser == 1.1 06:16:14 INFO - mozInstall == 1.13 06:16:14 INFO - mozcrash == 1.0 06:16:14 INFO - mozdebug == 0.1 06:16:14 INFO - mozdevice == 0.51 06:16:14 INFO - mozfile == 1.2 06:16:14 INFO - mozhttpd == 0.7 06:16:14 INFO - mozinfo == 0.10 06:16:14 INFO - mozleak == 0.1 06:16:14 INFO - mozlog == 3.5 06:16:14 INFO - moznetwork == 0.27 06:16:14 INFO - mozprocess == 0.25 06:16:14 INFO - mozprofile == 0.28 06:16:14 INFO - mozrunner == 6.13 06:16:14 INFO - mozscreenshot == 0.1 06:16:14 INFO - mozsystemmonitor == 0.3 06:16:14 INFO - moztest == 0.8 06:16:14 INFO - mozversion == 1.4 06:16:14 INFO - psutil == 3.1.1 06:16:14 INFO - requests == 1.2.3 06:16:14 INFO - wsgiref == 0.1.2 06:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:14 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:14 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 06:16:14 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 06:16:14 INFO - Using env: {'DISPLAY': ':0', 06:16:14 INFO - 'HOME': '/home/cltbld', 06:16:14 INFO - 'LANG': 'en_US.UTF-8', 06:16:14 INFO - 'LANGUAGE': 'en_US:en', 06:16:14 INFO - 'LOGNAME': 'cltbld', 06:16:14 INFO - 'MAIL': '/var/mail/cltbld', 06:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:14 INFO - 'MOZ_NO_REMOTE': '1', 06:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:14 INFO - 'NO_EM_RESTART': '1', 06:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:14 INFO - 'PWD': '/builds/slave/test', 06:16:14 INFO - 'SHELL': '/bin/bash', 06:16:14 INFO - 'SHLVL': '1', 06:16:14 INFO - 'TERM': 'linux', 06:16:14 INFO - 'TMOUT': '86400', 06:16:14 INFO - 'USER': 'cltbld', 06:16:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:14 INFO - '_': '/tools/buildbot/bin/python'} 06:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 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)) 06:16:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:16:14 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 06:16:14 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 06:16:14 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 06:16:14 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 06:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:16:17 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)) 06:16:17 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)) 06:16:17 INFO - Installing collected packages: simplejson 06:16:17 INFO - Running setup.py install for simplejson 06:16:17 INFO - building 'simplejson._speedups' extension 06:16:17 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 06:16:18 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 06:16:18 INFO - Successfully installed simplejson 06:16:18 INFO - Cleaning up... 06:16:18 INFO - Return code: 0 06:16:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:16:18 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')]} 06:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:18 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')]} 06:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:18 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 0x18ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', '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 06:16:18 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 06:16:18 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 06:16:18 INFO - Using env: {'DISPLAY': ':0', 06:16:18 INFO - 'HOME': '/home/cltbld', 06:16:18 INFO - 'LANG': 'en_US.UTF-8', 06:16:18 INFO - 'LANGUAGE': 'en_US:en', 06:16:18 INFO - 'LOGNAME': 'cltbld', 06:16:18 INFO - 'MAIL': '/var/mail/cltbld', 06:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:18 INFO - 'MOZ_NO_REMOTE': '1', 06:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:18 INFO - 'NO_EM_RESTART': '1', 06:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:18 INFO - 'PWD': '/builds/slave/test', 06:16:18 INFO - 'SHELL': '/bin/bash', 06:16:18 INFO - 'SHLVL': '1', 06:16:18 INFO - 'TERM': 'linux', 06:16:18 INFO - 'TMOUT': '86400', 06:16:18 INFO - 'USER': 'cltbld', 06:16:18 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:18 INFO - '_': '/tools/buildbot/bin/python'} 06:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:16:18 INFO - Cleaning up... 06:16:18 INFO - Return code: 0 06:16:18 INFO - Running post-action listener: _resource_record_post_action 06:16:18 INFO - Running post-action listener: _start_resource_monitoring 06:16:18 INFO - Starting resource monitoring. 06:16:18 INFO - [mozharness: 2017-09-17 13:16:18.490783Z] Finished create-virtualenv step (success) 06:16:18 INFO - [mozharness: 2017-09-17 13:16:18.491243Z] Running install step. 06:16:18 INFO - Running pre-action listener: _resource_record_pre_action 06:16:18 INFO - Running main action method: install 06:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:18 INFO - Reading from file tmpfile_stdout 06:16:18 INFO - Detecting whether we're running mozinstall >=1.0... 06:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:16:18 INFO - Reading from file tmpfile_stdout 06:16:18 INFO - Output received: 06:16:18 INFO - Usage: mozinstall [options] installer 06:16:18 INFO - Options: 06:16:18 INFO - -h, --help show this help message and exit 06:16:18 INFO - -d DEST, --destination=DEST 06:16:18 INFO - Directory to install application into. [default: 06:16:18 INFO - "/builds/slave/test"] 06:16:18 INFO - --app=APP Application being installed. [default: firefox] 06:16:18 INFO - mkdir: /builds/slave/test/build/application 06:16:18 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'] 06:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:16:36 INFO - Reading from file tmpfile_stdout 06:16:36 INFO - Output received: 06:16:36 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:36 INFO - Running post-action listener: _resource_record_post_action 06:16:36 INFO - [mozharness: 2017-09-17 13:16:36.604913Z] Finished install step (success) 06:16:36 INFO - [mozharness: 2017-09-17 13:16:36.605165Z] Running setup-mitmproxy step. 06:16:36 INFO - Running pre-action listener: _resource_record_pre_action 06:16:36 INFO - Running main action method: setup_mitmproxy 06:16:36 INFO - Skipping: mitmproxy is not required 06:16:36 INFO - Running post-action listener: _resource_record_post_action 06:16:36 INFO - [mozharness: 2017-09-17 13:16:36.606355Z] Finished setup-mitmproxy step (success) 06:16:36 INFO - [mozharness: 2017-09-17 13:16:36.606576Z] Running run-tests step. 06:16:36 INFO - Running pre-action listener: _resource_record_pre_action 06:16:36 INFO - Running pre-action listener: _set_gcov_prefix 06:16:36 INFO - Running main action method: run_tests 06:16:36 WARNING - Try message not found. 06:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:36 INFO - Python 2.7.3 06:16:36 INFO - Return code: 0 06:16:36 INFO - grabbing minidump binary from tooltool 06:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:36 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 0x1c6f090>, '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 0x1c6fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:36 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 06:16:36 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 06:16:36 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 06:16:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:36 INFO - Return code: 0 06:16:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:36 INFO - ENV: RUST_BACKTRACE is now full 06:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:36 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/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 06:16:36 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/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 06:16:36 INFO - Using env: {'DISPLAY': ':0', 06:16:36 INFO - 'HOME': '/home/cltbld', 06:16:36 INFO - 'LANG': 'en_US.UTF-8', 06:16:36 INFO - 'LANGUAGE': 'en_US:en', 06:16:36 INFO - 'LOGNAME': 'cltbld', 06:16:36 INFO - 'MAIL': '/var/mail/cltbld', 06:16:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:36 INFO - 'MOZ_ACCELERATED': '1', 06:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:36 INFO - 'MOZ_NO_REMOTE': '1', 06:16:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:36 INFO - 'MOZ_WEBRENDER': '1', 06:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:36 INFO - 'NO_EM_RESTART': '1', 06:16:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:36 INFO - 'PWD': '/builds/slave/test', 06:16:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:36 INFO - 'RUST_BACKTRACE': 'full', 06:16:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:16:36 INFO - 'SHELL': '/bin/bash', 06:16:36 INFO - 'SHLVL': '1', 06:16:36 INFO - 'TERM': 'linux', 06:16:36 INFO - 'TMOUT': '86400', 06:16:36 INFO - 'USER': 'cltbld', 06:16:36 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:36 INFO - '_': '/tools/buildbot/bin/python'} 06:16:36 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/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 06:16:36 INFO - mozversion application_buildid: 20170917122706 06:16:36 INFO - mozversion application_changeset: 877d536658e644bd0d1662d608cc2ca3a9fa8d9f 06:16:36 INFO - mozversion application_display_name: Nightly 06:16:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:36 INFO - mozversion application_name: Firefox 06:16:36 INFO - mozversion application_remotingname: firefox 06:16:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:16:36 INFO - mozversion application_vendor: Mozilla 06:16:36 INFO - mozversion application_version: 57.0a1 06:16:36 INFO - mozversion platform_buildid: 20170917122706 06:16:36 INFO - mozversion platform_changeset: 877d536658e644bd0d1662d608cc2ca3a9fa8d9f 06:16:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:16:36 INFO - mozversion platform_version: 57.0a1 06:16:36 INFO - using testdate: 1505654196 06:16:36 INFO - actual date: 1505654196 06:16:36 INFO - starting webserver on 'localhost:36941' 06:16:36 INFO - SUITE-START | Running 2 tests 06:16:36 INFO - TEST-START | dromaeo_css 06:16:36 INFO - Initialising browser for dromaeo_css test... 06:16:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36941/getInfo.html -profile /tmp/tmpez9hHZ/profile 06:16:36 INFO - TEST-INFO | started process 18575 (/builds/slave/test/build/application/firefox/firefox http://localhost:36941/getInfo.html) 06:16:44 INFO - TEST-INFO | 18575: exit 0 06:16:44 INFO - Browser initialized. 06:16:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:44 INFO - Using env: {'DISPLAY': ':0', 06:16:44 INFO - 'HOME': '/home/cltbld', 06:16:44 INFO - 'JSGC_DISABLE_POISONING': '1', 06:16:44 INFO - 'LANG': 'en_US.UTF-8', 06:16:44 INFO - 'LANGUAGE': 'en_US:en', 06:16:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:16:44 INFO - 'LOGNAME': 'cltbld', 06:16:44 INFO - 'MAIL': '/var/mail/cltbld', 06:16:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:44 INFO - 'MOZ_ACCELERATED': '1', 06:16:44 INFO - 'MOZ_CRASHREPORTER': '1', 06:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:16:44 INFO - 'MOZ_NO_REMOTE': '1', 06:16:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:44 INFO - 'MOZ_WEBRENDER': '1', 06:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:44 INFO - 'NO_EM_RESTART': '1', 06:16:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:44 INFO - 'PWD': '/builds/slave/test', 06:16:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:44 INFO - 'RUST_BACKTRACE': 'full', 06:16:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:16:44 INFO - 'SHELL': '/bin/bash', 06:16:44 INFO - 'SHLVL': '1', 06:16:44 INFO - 'TERM': 'linux', 06:16:44 INFO - 'TMOUT': '86400', 06:16:44 INFO - 'USER': 'cltbld', 06:16:44 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:44 INFO - '_': '/tools/buildbot/bin/python'} 06:16:44 INFO - TEST-INFO | started process 18821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpez9hHZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:45 INFO - PID 18821 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:16:45 INFO - PID 18821 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:16:45 INFO - PID 18821 | 06:16:45 INFO - PID 18821 | (/builds/slave/test/build/application/firefox/firefox:18880): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:45 INFO - PID 18821 | 06:16:56 INFO - PID 18821 | RSS: Main: 185147392 06:16:56 INFO - PID 18821 | 06:19:53 INFO - PID 18821 | Cycle 1(1): loaded http://localhost:36941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36941/tests/dromaeo/cssquery-ext.html) 06:19:54 INFO - PID 18821 | RSS: Main: 189800448 06:19:54 INFO - PID 18821 | 06:22:56 INFO - PID 18821 | Cycle 1(1): loaded http://localhost:36941/tests/dromaeo/cssquery-ext.html (next: http://localhost:36941/tests/dromaeo/cssquery-jquery.html) 06:22:57 INFO - PID 18821 | RSS: Main: 191578112 06:22:57 INFO - PID 18821 | 06:25:59 INFO - PID 18821 | Cycle 1(1): loaded http://localhost:36941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36941/tests/dromaeo/cssquery-mootools.html) 06:26:00 INFO - PID 18821 | RSS: Main: 193355776 06:26:00 INFO - PID 18821 | 06:29:02 INFO - PID 18821 | Cycle 1(1): loaded http://localhost:36941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36941/tests/dromaeo/cssquery-prototype.html) 06:29:02 INFO - PID 18821 | RSS: Main: 188301312 06:29:02 INFO - PID 18821 | 06:32:06 INFO - PID 18821 | Cycle 1(1): loaded http://localhost:36941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36941/tests/dromaeo/cssquery-yui.html) 06:32:06 INFO - PID 18821 | RSS: Main: 187236352 06:32:06 INFO - PID 18821 | 06:35:08 INFO - PID 18821 | Cycle 1(1): loaded http://localhost:36941/tests/dromaeo/cssquery-yui.html (next: http://localhost:36941/tests/dromaeo/cssquery-dojo.html) 06:35:09 INFO - PID 18821 | RSS: Main: 191877120 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | __start_tp_report 06:35:09 INFO - PID 18821 | _x_x_mozilla_page_load 06:35:09 INFO - PID 18821 | _x_x_mozilla_page_load_details 06:35:09 INFO - PID 18821 | |i|pagename|runs| 06:35:09 INFO - PID 18821 | |0;dojo.html;3121.6566177720456;3151.4484965131096;3153.826539540326;3154.227214332489;3154.3375891062874;6060.030395136779;6196.504279657623;6260.906086408708;6278.2779980302275;6281.277653069898;6160.045192995093;6194.907076393858;6200.78297259596;6211.223597050369;6219.595726277788;5651.208830763697;5696.9745445819735;5753.510951569122;5788.18965344852;5871.941280587203;5741.19623252745;5778.971105144468;5807.332156801958;5812.0119579671555;5833.445822646841;47.71254017176514;5224.052307633303;5524.696141712204;5591.3569939456875;5719.28508936383;5627.831165065055;5634.859128521779;5665.291838520185;5669.489745922846;5683.9715801420725;5577.944220557783;5584.553235741171;5604.607677462579;5624.690642014688;5626.774929002835;6124.479419249369;6180.505559555269;6180.81457556274;6205.906911396332;6236.03341482071;6555.508336874754;6575.046618240328;6683.365080317362;6687.665616719145;6689.6989635466525;6550.115734375846;6602.504812139109;6616.603003819786;6702.631355275458;6711.362420570038;6145.477634401082;6183.1034499997695;6258.937410625881;6273.654948977804;6282.560220784547;6855.931440685629;6946.305369463013;6953.061336719579;6957.06079679247;6961.930380696128;6537.215534135839;6572.539922205496;6581.80254592363;6616.801495955129;6624.0395142705;6455.4835613150835;6594.472442204708;6601.174853143357;6603;6607.636579988147;6510.18622672166;6527.2167339919515;6562.343765623495;6567.146270984741;6570.244421891448;6471.7734879279;6540.215174179129;6573.704183311763;6591.967040164865;6610.0745895574655;5152.407473140637;5296.3379577552805;5298.867528311823;5308.442613525602;5333;4560.065186636732;4641.791119399635;4666.766661666903;4678.906421871544;4680.695754775928;5710.343310519261;5739.713014349266;5750.712464376765;5808.419158084158;5836.7957121501395;6470.417662410406;6612.834679132964;6639.535232533773;6645.900311495331;6650.467962562983;5618.4662457066515;5675.659460432387;5682.886342273214;5728.541716662657;5821;5749.080147176432;5787.71061446926;5788.594798364074;5797.826065218051;5799.88400231993;6488.480921526267;6517.120188774549;6583.572067815577;6588.242352129567;6591;6400.135981642418;6512.6092434454085;6515.413612774873;6569.9014514783275;6589.143411356589;6432;6451.774187903401;6454.322296158835;6457.321981191907;6457.61254324742;6445.355464453517;6480.740770369132;6491.221053473613;6511.869762604816;6513.641749703812;5697.158876275079;6593.340665933369;6620.801375958729;6647.135872336566;6745.898811517929;6471.708773105316;6480.513961453004;6482.611043337415;6556.803295901131;6564.80305590833;6225;6410.775622853178;6452.35476452351;6545.5090868184125;6573.079768832272;6323.241211054703;6370.267419246846;6414.61512309263;6427.678616069272;6448.226212854487;6541.443977261986;6554.213494380705;6560.901586476111;6568.047633093271;6587.4071333580205;6265;6312;6327.936720632735;6377.266614339224;6393.744250230125 06:35:09 INFO - PID 18821 | |1;ext.html;864.5590748718154;882.4176043811086;883.461088735871;887.2680038967853;888.2006194425016;38467.61532384675;41462.37806432902;41661.375079373836;41748.791256043674;41855.16289674205;38340;38553.421698674545;38586.22827543448;38647;38665.61334386655;6991.930080699191;7111.53775004623;7122.679479423413;7140.535865168773;7145.464090193231;7080.150381954173;7099.183593886692;7105.609191494465;7107.6090815005155;7182.46131540134;7055.682494287769;7070.717171313141;7071.398931090837;7131.89302160468;7132.85734285314;6988.301169883021;7638.541687498768;7844.843103137905;7858.1356050834365;7879.487833290817;7752.418568607321;7768.689252429896;7827.530348179127;7856;7867.095284042294;37683.62316376856;38047.23905521874;38090;38218;38494.80752596219;3561.0919215600115;3584.5160903277983;3584.8207589620674;3585.049961760136;3609.7653652512763;32404.351912961843;32487.83756081228;32551.348973020406;32554.02337929866;32606.83696581502;5082.364704411949;5273.419923808378;5278.1291086970605;5303.124984377573;5385.5960802939935;167970;178855.9999999987;180177;180652;181935.09032454886;40852.79573602113;42281.57718422838;47483.52516474791;47689.76155119202;47848.52151478441;50477.74761126171;51858.74070629623;51876.48123518792;51886;52048.47951520512;16309.592260193353;16553.420630277884;16584.419545315857;16690.248938797784;16718.164091795363;13684.452621895012;13688.178709277476;13705.794413083811;13739.106958047694;13756;13905.192324997888;13913.860861391458;13994.580162595139;14014.159150451005;14051.78922316166;5429.104197807396;5440.510354068153;5556.333240011225;5617.129344951539;5619.325680918316;986.7385142937128;1015.2537884654773;1018.4042335233971;1037.5331101004579;1041.3595638682157;23886;23929.64105538418;23970;24163.275101746975;24319.239923952715;1107.0977153619774;1132.8753837077916;1149.1553708024596;1151.9424028798526;1160.5415860735131;12685.873141268654;12712.42794074269;12753.872461275454;12833.165844220095;12939.288339141249;225048;225282;225378;226229;226893;53130;53448;53458.732706336996;53801.46198537965;53870;1387.8681525255085;1447.6815100677834;1472.8465726650957;1478.4529724001973;1481.2445652716976;22841.428964276027;22927.197548085736;23192.652110218696;23205;23720;37859;37930.241395172496;37939.05152371213;38013.239735205694;38016.619833801306;192935;193642;193773;194033;195555;30825;34698;34953.65046349606;35017.474737879464;35532;44344.334834978144;44878;45033.77483112564;45203.77398112988;45667.54332456766;32205.677943220267;32606.673933260365;32896.342073158885;33002.17494562655;33635;32128.518072228468;32254.35491290114;32435.513467297536;32582.185445364055;32616.510752338258;36181.81909090438;36244.1932332471;36334.27331453409;36551;36752.44871326879;31502.369952600362;31793.364132717677;32205.194870128435;32214.35571288608;32463.18842028968;23831.761682383647;23951.880240598686;24431.38921526976;24544.877275613508;24600.384990375383 06:35:09 INFO - PID 18821 | |2;jquery.html;558.7820749907539;561.278756797515;562.558391662545;584.514852672282;599.364673446147;22191.334259972187;22895.42761430963;23125.421864453398;23152.536949261004;23214.88392558037;23730.16944406942;24603.63094553583;24688;24881.87559062207;25314.74685253147;6448.645324507139;6578.60528368297;6581.045748366508;6581.210254769434;6625.370589793962;6429.8714025719455;6490.221173459192;6548.345165483461;6550.770723024695;6553.50848686348;6154.384561543855;6416.935830641703;6418.454431373339;6432.13166222561;6481.837954051163;6356.014817703263;6387.265464471576;6387.489000879942;6423.132877061584;6428.742850285983;5968.283805943314;5984.281886173643;5986.6707331097205;6008.218931538916;6444.613323200623;30118;30808.537871931938;30816.691833081608;30947.381052379053;30973.22566935822;2134.6371116910163;2148.473623962124;2151.376100930728;2157.719496465465;2174.402039439151;19974;20349.18603255868;20660.380188594365;20702.58594828095;21322.893385533127;2568.845869247851;2604.5832666773413;2661.3745769744096;2665.3869609989615;2673.6123262126885;125195;131882.34058829644;132353.3382333092;133046.33476832652;141603.29198354046;20123.496912577302;20423;20429;21283;21316.78683213179;41783.1643367137;41900.790496047935;42036.57963420327;42222.15555688869;42275.15449690989;10655.680329590125;10689.572417103229;10823.350598964087;10834.916508349103;10898.782024359627;8995.235404990519;9017.63929442828;9060.592273347715;9165.725028249164;9171.174594286413;10750.677479675622;10811.513481893177;10832.566697332177;11102.777944441228;11463.656090317303;3640.9453858192146;4010.418489319091;4199.307114326163;4250.553691862372;4423.889402764892;965.932384733076;968.4237878462303;978.3836183204678;980;983.7491439682835;18680;18882.150303236387;19389;19457.513562160777;19571.315003974792;1043.4678314059884;1046.267612671118;1057.5505410200633;1060.3372891942536;1062.654637242899;10563.947180264204;10711.83932241017;10716.892831071746;10736.546878196892;10739.463026848782;479528;486905;486954.3071161049;488685;490512;108336;109194;110121;111392;112965.43517282525;1153.2273376837538;1158.6813626252847;1178.8113901775675;1198.4846515998204;1200.327816422806;16927.496334420422;16933.915330423268;17053.57366065858;17103.657926841643;17114.315427382764;53910;54902.72548637391;55306.72346638402;55480.44519554753;56088.71955640196;68080.3191968074;68185.3181468179;68324;69392.3060769406;69455.65272173607;18234.908825455786;19637;19738.111784969424;19782.90108549448;19906.800931991074;22167.33497995063;22437.43906402353;22440.43898902475;22512.32463026112;22936.88531557398;18052.458426247234;18156.27374905042;18253.361132360835;18285.81714182841;18291.634167316846;16124.596885077966;16398.09810460436;16457.835421645632;16597.004179749252;16749.832501674828;18288;18385.90807045956;18416.539586510444;18452.63094738071;18792;17763.911180444014;18930;19012.524686882385;19021.048947552845;19185.61628767445;17550.06772324899;17599.29602815873;17603.55991100233;17617.383391581232;17662.64674706473 06:35:09 INFO - PID 18821 | |3;mootools.html;1285.8135570342301;1369.7534443800116;1408.2114016150956;1411.3719394869288;1414.5968399006285;14572.781408278872;15197.24013799311;15198.240087995597;15200.771988420183;15216.543503694878;14905.32926018329;14992;15021.474248401308;15024.549263522085;15104.622384440367;2569.974300256992;2570.100464837306;2621.750933661309;2636.736326367367;2642.9735702643015;2602.154299852546;2624.619430182622;2651.4431969286375;2652.376691477501;2656.256248250483;2717.877695503707;2741.3420779012995;2752.545829938058;2805.3126983888974;2837.6027356170152;2800.4679110968955;2836.61705669734;2839.346950201465;2843.772498200139;2844.886204551826;2551.5917453207585;2553.0681301325067;2560.129555950986;2586.728393518691;2587.32729490332;14166.645833854132;14847.406103755944;15337.46318878845;15408.691826163526;15476.613084672974;8100.392470564731;8417.705380311721;8420.368472364597;8424.283935865458;8426.283765879907;5325.281087053237;5413.891722165535;5514.255575497336;5523.2543606613;5571.721413929287;1819.3995981326132;1855.749473821044;1889.5559543507266;1905.6284024615206;1907.542189874434;25988.480230395475;26518.602220966703;26561;26615.866920665467;26646;7276.345128938421;7297.664747280819;7323.157836848831;7454.366378857858;7501.649703053394;20060.09729562144;20076.09657565413;20120.798792011894;20121.899390502953;20133.597328053358;8235.547044912588;8402.075771665111;8403.07566167721;8405.873911891327;8413.621387037598;7218.45861560385;7440.3675687567165;7451.403887688972;7482.027336446227;7510.924890751132;5445.83662490126;5634.915476267777;5699.145128230799;5706.343770466367;5797.971010144923;1745.642143360608;1800.9549761256073;1806.2774890044088;1835.5686413692772;1858.3960212930851;879.2262808728278;899.5322432335149;901.4816480523725;916.0381599320687;921.0145144695246;7620.961895190489;7626.122995855437;7640.80897977555;7656;7717.961410193026;719.665355609644;720.1610124205347;721.7654262364753;727.3599232675211;743.4201322968094;4412.602865742098;4555.612772914273;4581.518940511265;5087.236914462786;5230.372355317386;20045.899770501055;20853.37439876806;20882.79117208839;21352.893235534033;21650;20295.695564566544;20408.795912040987;20530.07614657344;21284.574308513744;21591.892040539697;10970.561177552809;11011.779764404668;11037.282576632653;11121.443927803577;11267.54929802815;8219.178082191733;8483.151684831468;8620.267277281502;8657.134286571292;8661.956690216508;18055.729164062286;18123;18680.906595466935;18800.7179892299;19070.904645476683;18806;19207.903960480107;19551.511212219808;19605.31381401644;19780.40658780239;12002.579909703118;12043.277403355827;12110.394480276127;12129.272243665408;12138.696532586757;13875.930620346833;13882.375293112036;13976.650583735487;14045.227512486912;14107.153570785786;10403.895961040293;10409;10658.360498369813;10767.138628909825;10858.45707714627;10737.892621074001;10793.190510711886;10923.890761092605;10926.344419334866;11171.944140279247;9565.904340956502;9677.564509597225;9692.612295508383;9705.417674939526;9720.805583888141;6958.79123626292;6974.546654467444;7019.3682568569075;7037.225905150532;7050.788476345718;6943.652817359213;7145.214026456982;7189.712411503481;7242.855142897007;7326.4138868889295 06:35:09 INFO - PID 18821 | |4;prototype.html;499.2810353091548;502.6501107323264;523.1470221816321;528.3870709976428;533.1469648562299;6196.752129914798;6201.287021863388;6234.220722409699;6264.874702505947;6326.968365158179;6115.663638499881;6141.692915354226;6151.569390142692;6173.691315434233;6260.154879091321;5085.982803439309;5118.155504341779;5157.638965272433;5171.974140129313;5178.48215178481;5174.948250517485;5182.766775495112;5185.688858668492;5225.335079109663;5236.92144617831;4727.787249573777;4906.681065730734;5030.245463180534;5102.489751024905;5106.69359838409;4874.65877388583;4893.75531223441;4899.093667671475;4914.533119353674;4943.555080042777;4351.456067991501;4380.233459144637;4380.978095109536;4386.956130438687;4398.670099742532;5879.412058794129;6032.396760323976;6050.878982420327;6137.110119032715;6140.570160088796;5638.689872057035;5666.433356664342;5694.316681998145;5706.315242170925;5708.885822283572;6409.3590640936;6471.288158302583;6482.7406903723795;6509.739610415578;6519.804405867784;4640.744759038252;4804.183288840905;4814.542618451242;4838.346823178861;4841;6569.80290591283;6701.597904125768;6710.530262881552;6711.731530738764;6751.797446076625;4883.536064073907;4892.926606100911;4933.728644924492;4944.554990050912;4945.9258111128365;4944.258361245842;4981.302617633534;5002;5011.473795251446;5012.724300163453;5523.392426833045;5544.63959842609;5610.382857885629;5622.128570071645;5650.717464126859;6476.481881449473;6520.630667559865;6538.8365290868105;6572.507061970371;6578.63817490033;1729.5330260829505;1734.167599552222;1741.9912900435418;1751.9737203941952;1764.1443899708631;1123.7078359626391;1204.9698757531132;1209.6673414810998;1211.5396149463147;1213.3447938113497;5580.832575022756;5652.9152062719095;5663.292088488939;5684.63049901755;5715.685637289906;6560.343965603402;6600.60396376219;6606.306337834554;6633.635150066792;6656.101426307483;5579.637323573955;5605.467480589337;5622.91565626516;5665.801696940587;5702.771889124471;3446.7070299024363;3448.74134439913;3491.1970246843366;3498.422760244531;3533.8056406897354;6229.5327850410495;6300.432961033529;6368.713407896656;6405.19935008124;6445;6617.371349721769;6625.3374662534325;6678.198616166092;6694.933050669529;6704.363085506967;6416.262129855033;6445.484361251089;6490.513211509156;6495.960646296664;6533.575317604531;6081.726322315418;6506.4469520091325;6553.4611309892125;6604.3725846044545;6616.437602803623;6465.191851018622;6479.347766319747;6485.805425837232;6492.577982431127;6508.251551071688;6323.810285691437;6362.268339141058;6392.360763923756;6392.4246817786625;6399.55203135776;4939.110960027229;5236.653577530565;5405.9459405407015;5435.809746659006;5449.6730196188355;6278.215223097113;6295.18162638854;6410.423061924449;6572.7042283098335;6710.328967103251;6312.936870631235;6314.715837787402;6440.484761218998;6440.516961227833;6537.738490460519;6265.467435268053;6325;6351.301356850835;6428.100065990859;6485;6216.160818289473;6274.874502510015;6321.715522801393;6337.873242535031;6356.364363563606;6481.967590162019;6517.250516190698;6532.477401807939;6534.444572211415;6555.115059467102;6228.34602366745;6262.2172228471445;6279.215098112736;6287.402696743802;6345.8730825384155 06:35:09 INFO - PID 18821 | |5;yui.html;889.2174886100231;915;928.5125309212663;931.1573026411096;944.5796620503876;18829.529261768446;19610.803891961077;19619.70570441441;19682.803171968277;19706.80293197066;16925.59076168154;17440.912795436005;17594.384196553125;19119.426417207473;19624.705629415534;965.0879918477025;973.4694591447643;988.5650313861878;989.3272574649236;989.4310771306491;989.7575094101956;1002.6540843409012;1003.2124782046095;1006.9395836249812;1007.9748006299828;1016.806806706727;1044.9216308776834;1055.1347894726289;1058;1058.9682309530726;1019;1027.0961553832578;1027.1628622672497;1029.521272608237;1040.7970445763078;747.9962600187018;748.2367984655621;751.8195633048084;751.9285667861544;757.6666266842572;20044.398668039983;20107.095180716755;20425.69361459579;20428.897855510775;20442.38672839817;21859.125634974742;22084.11663533457;22253.888730556242;22328.330150095524;22386.55226895453;17084.572885677833;17186.57033574158;17254.3960961367;17297.567560810956;17362.305507779674;3692.3169213695282;3724.981375093107;3729.2914346274392;3734.551853777537;3744.101415660249;136792;137487;138001;138976.99999999898;140533;16750.664986700198;16805.747913781302;16907.492775216764;16967.660646786993;17100.914495427693;32109.678903210668;32186.83906580499;32426.513602295985;32485;32513;7919.089304729914;7928.8810667840025;7946.364290856717;8056.677732890619;8066.193380661887;4431.711938723973;4530.161920044802;4536;4546.636269098464;4552.521985191507;5391.811286605029;5484.232207490954;5490.80782172622;5504.532114770209;5513.807016754395;914.8033172867865;998.1615443027746;1011.2567263061644;1017.97455063624;1019.1133713669155;667.6828506459393;681.7136802542844;691.0084029417801;692.9826754331182;699.0876905638089;11322.603708870314;11500.773851291202;11662.708432289091;11999.820002699966;12142.028637708961;637.3499030988365;637.7799659117597;647.795944277551;652.9347065293433;665.0921492163162;5591.384947655754;5607.719614019365;5613.106238449612;5689.402612725604;5778.075507918713;117055;119926.40036799935;125293;125729;126467;107953.4602326999;109089.45455272673;112357;113376;115679;97354.51322743483;97998;98820.50589747149;99117;99363.50318248362;10199.235057370579;10270.845937311096;10627.893721063;10636.8936310639;10639.361638301727;42931.7853410731;43003;43977;44393;44879.32681009853;53852;55933;56303.71848140733;56983;57480.425195747506;15319.923400382926;15703.842961570695;15776.842231577537;15808;15931.761023584888;16649.833501664827;16935.66128677395;16986.405475808286;17035.574110647332;17219.31122755076;15641.608959776097;15825.129617871127;15902.443414480438;15942.68114637724;16181.4336498222;13682.384292706653;13796;13808.585742427744;13878.930605346908;13926.651833703832;15378.69242615119;15405;15457.227138643248;15568.766468502756;15913.681726365176;11426.828597570877;11658.300501969909;11684.70788230301;11890.405479726152;11978.46096925658;11495.425228738697;11610.129240306842;11635.127365447795;11760.764784704086;11938 06:35:09 INFO - PID 18821 | __end_tp_report 06:35:09 INFO - PID 18821 | __start_cc_report 06:35:09 INFO - PID 18821 | _x_x_mozilla_cycle_collect,299 06:35:09 INFO - PID 18821 | __end_cc_report 06:35:09 INFO - PID 18821 | __startTimestamp1505655309127__endTimestamp 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | ------- Summary: start ------- 06:35:09 INFO - PID 18821 | Number of tests: 6 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | [#0] dojo.html Cycles:165 Average:6066.08 Median:6377.27 stddev:859.37 (13.5%) stddev-sans-first:830.38 06:35:09 INFO - PID 18821 | Values: 3121.7 3151.4 3153.8 3154.2 3154.3 6060.0 6196.5 6260.9 6278.3 6281.3 6160.0 6194.9 6200.8 6211.2 6219.6 5651.2 5697.0 5753.5 5788.2 5871.9 5741.2 5779.0 5807.3 5812.0 5833.4 47.7 5224.1 5524.7 5591.4 5719.3 5627.8 5634.9 5665.3 5669.5 5684.0 5577.9 5584.6 5604.6 5624.7 5626.8 6124.5 6180.5 6180.8 6205.9 6236.0 6555.5 6575.0 6683.4 6687.7 6689.7 6550.1 6602.5 6616.6 6702.6 6711.4 6145.5 6183.1 6258.9 6273.7 6282.6 6855.9 6946.3 6953.1 6957.1 6961.9 6537.2 6572.5 6581.8 6616.8 6624.0 6455.5 6594.5 6601.2 6603.0 6607.6 6510.2 6527.2 6562.3 6567.1 6570.2 6471.8 6540.2 6573.7 6592.0 6610.1 5152.4 5296.3 5298.9 5308.4 5333.0 4560.1 4641.8 4666.8 4678.9 4680.7 5710.3 5739.7 5750.7 5808.4 5836.8 6470.4 6612.8 6639.5 6645.9 6650.5 5618.5 5675.7 5682.9 5728.5 5821.0 5749.1 5787.7 5788.6 5797.8 5799.9 6488.5 6517.1 6583.6 6588.2 6591.0 6400.1 6512.6 6515.4 6569.9 6589.1 6432.0 6451.8 6454.3 6457.3 6457.6 6445.4 6480.7 6491.2 6511.9 6513.6 5697.2 6593.3 6620.8 6647.1 6745.9 6471.7 6480.5 6482.6 6556.8 6564.8 6225.0 6410.8 6452.4 6545.5 6573.1 6323.2 6370.3 6414.6 6427.7 6448.2 6541.4 6554.2 6560.9 6568.0 6587.4 6265.0 6312.0 6327.9 6377.3 6393.7 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | [#1] ext.html Cycles:180 Average:37038.76 Median:3584.67 stddev:51827.99 (1445.8%) stddev-sans-first:51902.20 06:35:09 INFO - PID 18821 | Values: 864.6 882.4 883.5 887.3 888.2 38467.6 41462.4 41661.4 41748.8 41855.2 38340.0 38553.4 38586.2 38647.0 38665.6 6991.9 7111.5 7122.7 7140.5 7145.5 7080.2 7099.2 7105.6 7107.6 7182.5 7055.7 7070.7 7071.4 7131.9 7132.9 6988.3 7638.5 7844.8 7858.1 7879.5 7752.4 7768.7 7827.5 7856.0 7867.1 37683.6 38047.2 38090.0 38218.0 38494.8 3561.1 3584.5 3584.8 3585.0 3609.8 32404.4 32487.8 32551.3 32554.0 32606.8 5082.4 5273.4 5278.1 5303.1 5385.6 167970.0 178856.0 180177.0 180652.0 181935.1 40852.8 42281.6 47483.5 47689.8 47848.5 50477.7 51858.7 51876.5 51886.0 52048.5 16309.6 16553.4 16584.4 16690.2 16718.2 13684.5 13688.2 13705.8 13739.1 13756.0 13905.2 13913.9 13994.6 14014.2 14051.8 5429.1 5440.5 5556.3 5617.1 5619.3 986.7 1015.3 1018.4 1037.5 1041.4 23886.0 23929.6 23970.0 24163.3 24319.2 1107.1 1132.9 1149.2 1151.9 1160.5 12685.9 12712.4 12753.9 12833.2 12939.3 225048.0 225282.0 225378.0 226229.0 226893.0 53130.0 53448.0 53458.7 53801.5 53870.0 1387.9 1447.7 1472.8 1478.5 1481.2 22841.4 22927.2 23192.7 23205.0 23720.0 37859.0 37930.2 37939.1 38013.2 38016.6 192935.0 193642.0 193773.0 194033.0 195555.0 30825.0 34698.0 34953.7 35017.5 35532.0 44344.3 44878.0 45033.8 45203.8 45667.5 32205.7 32606.7 32896.3 33002.2 33635.0 32128.5 32254.4 32435.5 32582.2 32616.5 36181.8 36244.2 36334.3 36551.0 36752.4 31502.4 31793.4 32205.2 32214.4 32463.2 23831.8 23951.9 24431.4 24544.9 24600.4 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | [#2] jquery.html Cycles:180 Average:35252.20 Median:22179.33 stddev:81554.83 (367.7%) stddev-sans-first:81742.02 06:35:09 INFO - PID 18821 | Values: 558.8 561.3 562.6 584.5 599.4 22191.3 22895.4 23125.4 23152.5 23214.9 23730.2 24603.6 24688.0 24881.9 25314.7 6448.6 6578.6 6581.0 6581.2 6625.4 6429.9 6490.2 6548.3 6550.8 6553.5 6154.4 6416.9 6418.5 6432.1 6481.8 6356.0 6387.3 6387.5 6423.1 6428.7 5968.3 5984.3 5986.7 6008.2 6444.6 30118.0 30808.5 30816.7 30947.4 30973.2 2134.6 2148.5 2151.4 2157.7 2174.4 19974.0 20349.2 20660.4 20702.6 21322.9 2568.8 2604.6 2661.4 2665.4 2673.6 125195.0 131882.3 132353.3 133046.3 141603.3 20123.5 20423.0 20429.0 21283.0 21316.8 41783.2 41900.8 42036.6 42222.2 42275.2 10655.7 10689.6 10823.4 10834.9 10898.8 8995.2 9017.6 9060.6 9165.7 9171.2 10750.7 10811.5 10832.6 11102.8 11463.7 3640.9 4010.4 4199.3 4250.6 4423.9 965.9 968.4 978.4 980.0 983.7 18680.0 18882.2 19389.0 19457.5 19571.3 1043.5 1046.3 1057.6 1060.3 1062.7 10563.9 10711.8 10716.9 10736.5 10739.5 479528.0 486905.0 486954.3 488685.0 490512.0 108336.0 109194.0 110121.0 111392.0 112965.4 1153.2 1158.7 1178.8 1198.5 1200.3 16927.5 16933.9 17053.6 17103.7 17114.3 53910.0 54902.7 55306.7 55480.4 56088.7 68080.3 68185.3 68324.0 69392.3 69455.7 18234.9 19637.0 19738.1 19782.9 19906.8 22167.3 22437.4 22440.4 22512.3 22936.9 18052.5 18156.3 18253.4 18285.8 18291.6 16124.6 16398.1 16457.8 16597.0 16749.8 18288.0 18385.9 18416.5 18452.6 18792.0 17763.9 18930.0 19012.5 19021.0 19185.6 17550.1 17599.3 17603.6 17617.4 17662.6 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | [#3] mootools.html Cycles:180 Average:9379.29 Median:2630.68 stddev:6711.06 (255.1%) stddev-sans-first:6702.34 06:35:09 INFO - PID 18821 | Values: 1285.8 1369.8 1408.2 1411.4 1414.6 14572.8 15197.2 15198.2 15200.8 15216.5 14905.3 14992.0 15021.5 15024.5 15104.6 2570.0 2570.1 2621.8 2636.7 2643.0 2602.2 2624.6 2651.4 2652.4 2656.3 2717.9 2741.3 2752.5 2805.3 2837.6 2800.5 2836.6 2839.3 2843.8 2844.9 2551.6 2553.1 2560.1 2586.7 2587.3 14166.6 14847.4 15337.5 15408.7 15476.6 8100.4 8417.7 8420.4 8424.3 8426.3 5325.3 5413.9 5514.3 5523.3 5571.7 1819.4 1855.7 1889.6 1905.6 1907.5 25988.5 26518.6 26561.0 26615.9 26646.0 7276.3 7297.7 7323.2 7454.4 7501.6 20060.1 20076.1 20120.8 20121.9 20133.6 8235.5 8402.1 8403.1 8405.9 8413.6 7218.5 7440.4 7451.4 7482.0 7510.9 5445.8 5634.9 5699.1 5706.3 5798.0 1745.6 1801.0 1806.3 1835.6 1858.4 879.2 899.5 901.5 916.0 921.0 7621.0 7626.1 7640.8 7656.0 7718.0 719.7 720.2 721.8 727.4 743.4 4412.6 4555.6 4581.5 5087.2 5230.4 20045.9 20853.4 20882.8 21352.9 21650.0 20295.7 20408.8 20530.1 21284.6 21591.9 10970.6 11011.8 11037.3 11121.4 11267.5 8219.2 8483.2 8620.3 8657.1 8662.0 18055.7 18123.0 18680.9 18800.7 19070.9 18806.0 19207.9 19551.5 19605.3 19780.4 12002.6 12043.3 12110.4 12129.3 12138.7 13875.9 13882.4 13976.7 14045.2 14107.2 10403.9 10409.0 10658.4 10767.1 10858.5 10737.9 10793.2 10923.9 10926.3 11171.9 9565.9 9677.6 9692.6 9705.4 9720.8 6958.8 6974.5 7019.4 7037.2 7050.8 6943.7 7145.2 7189.7 7242.9 7326.4 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | [#4] prototype.html Cycles:180 Average:5445.60 Median:6138.84 stddev:1508.48 (24.6%) stddev-sans-first:1466.32 06:35:09 INFO - PID 18821 | Values: 499.3 502.7 523.1 528.4 533.1 6196.8 6201.3 6234.2 6264.9 6327.0 6115.7 6141.7 6151.6 6173.7 6260.2 5086.0 5118.2 5157.6 5172.0 5178.5 5174.9 5182.8 5185.7 5225.3 5236.9 4727.8 4906.7 5030.2 5102.5 5106.7 4874.7 4893.8 4899.1 4914.5 4943.6 4351.5 4380.2 4381.0 4387.0 4398.7 5879.4 6032.4 6050.9 6137.1 6140.6 5638.7 5666.4 5694.3 5706.3 5708.9 6409.4 6471.3 6482.7 6509.7 6519.8 4640.7 4804.2 4814.5 4838.3 4841.0 6569.8 6701.6 6710.5 6711.7 6751.8 4883.5 4892.9 4933.7 4944.6 4945.9 4944.3 4981.3 5002.0 5011.5 5012.7 5523.4 5544.6 5610.4 5622.1 5650.7 6476.5 6520.6 6538.8 6572.5 6578.6 1729.5 1734.2 1742.0 1752.0 1764.1 1123.7 1205.0 1209.7 1211.5 1213.3 5580.8 5652.9 5663.3 5684.6 5715.7 6560.3 6600.6 6606.3 6633.6 6656.1 5579.6 5605.5 5622.9 5665.8 5702.8 3446.7 3448.7 3491.2 3498.4 3533.8 6229.5 6300.4 6368.7 6405.2 6445.0 6617.4 6625.3 6678.2 6694.9 6704.4 6416.3 6445.5 6490.5 6496.0 6533.6 6081.7 6506.4 6553.5 6604.4 6616.4 6465.2 6479.3 6485.8 6492.6 6508.3 6323.8 6362.3 6392.4 6392.4 6399.6 4939.1 5236.7 5405.9 5435.8 5449.7 6278.2 6295.2 6410.4 6572.7 6710.3 6312.9 6314.7 6440.5 6440.5 6537.7 6265.5 6325.0 6351.3 6428.1 6485.0 6216.2 6274.9 6321.7 6337.9 6356.4 6482.0 6517.3 6532.5 6534.4 6555.1 6228.3 6262.2 6279.2 6287.4 6345.9 06:35:09 INFO - PID 18821 | 06:35:09 INFO - PID 18821 | [#5] yui.html Cycles:180 Average:24360.64 Median:18974.48 stddev:35577.32 (187.5%) stddev-sans-first:35633.47 06:35:09 INFO - PID 18821 | Values: 889.2 915.0 928.5 931.2 944.6 18829.5 19610.8 19619.7 19682.8 19706.8 16925.6 17440.9 17594.4 19119.4 19624.7 965.1 973.5 988.6 989.3 989.4 989.8 1002.7 1003.2 1006.9 1008.0 1016.8 1044.9 1055.1 1058.0 1059.0 1019.0 1027.1 1027.2 1029.5 1040.8 748.0 748.2 751.8 751.9 757.7 20044.4 20107.1 20425.7 20428.9 20442.4 21859.1 22084.1 22253.9 22328.3 22386.6 17084.6 17186.6 17254.4 17297.6 17362.3 3692.3 3725.0 3729.3 3734.6 3744.1 136792.0 137487.0 138001.0 138977.0 140533.0 16750.7 16805.7 16907.5 16967.7 17100.9 32109.7 32186.8 32426.5 32485.0 32513.0 7919.1 7928.9 7946.4 8056.7 8066.2 4431.7 4530.2 4536.0 4546.6 4552.5 5391.8 5484.2 5490.8 5504.5 5513.8 914.8 998.2 1011.3 1018.0 1019.1 667.7 681.7 691.0 693.0 699.1 11322.6 11500.8 11662.7 11999.8 12142.0 637.3 637.8 647.8 652.9 665.1 5591.4 5607.7 5613.1 5689.4 5778.1 117055.0 119926.4 125293.0 125729.0 126467.0 107953.5 109089.5 112357.0 113376.0 115679.0 97354.5 97998.0 98820.5 99117.0 99363.5 10199.2 10270.8 10627.9 10636.9 10639.4 42931.8 43003.0 43977.0 44393.0 44879.3 53852.0 55933.0 56303.7 56983.0 57480.4 15319.9 15703.8 15776.8 15808.0 15931.8 16649.8 16935.7 16986.4 17035.6 17219.3 15641.6 15825.1 15902.4 15942.7 16181.4 13682.4 13796.0 13808.6 13878.9 13926.7 15378.7 15405.0 15457.2 15568.8 15913.7 11426.8 11658.3 11684.7 11890.4 11978.5 11495.4 11610.1 11635.1 11760.8 11938.0 06:35:09 INFO - PID 18821 | -------- Summary: end -------- 06:35:09 INFO - PID 18821 | 06:35:09 INFO - TEST-INFO | 18821: exit 0 06:35:10 INFO - TEST-OK | dromaeo_css | took 1113038ms 06:35:10 INFO - TEST-START | kraken 06:35:10 INFO - Initialising browser for kraken test... 06:35:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36941/getInfo.html -profile /tmp/tmp1sHcGa/profile 06:35:10 INFO - TEST-INFO | started process 19213 (/builds/slave/test/build/application/firefox/firefox http://localhost:36941/getInfo.html) 06:35:15 INFO - TEST-INFO | 19213: exit 0 06:35:16 INFO - Browser initialized. 06:35:16 INFO - Running cycle 1/1 for kraken test... 06:35:16 INFO - Using env: {'DISPLAY': ':0', 06:35:16 INFO - 'HOME': '/home/cltbld', 06:35:16 INFO - 'JSGC_DISABLE_POISONING': '1', 06:35:16 INFO - 'LANG': 'en_US.UTF-8', 06:35:16 INFO - 'LANGUAGE': 'en_US:en', 06:35:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:35:16 INFO - 'LOGNAME': 'cltbld', 06:35:16 INFO - 'MAIL': '/var/mail/cltbld', 06:35:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:35:16 INFO - 'MOZ_ACCELERATED': '1', 06:35:16 INFO - 'MOZ_CRASHREPORTER': '1', 06:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:35:16 INFO - 'MOZ_NO_REMOTE': '1', 06:35:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:16 INFO - 'MOZ_WEBRENDER': '1', 06:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:16 INFO - 'NO_EM_RESTART': '1', 06:35:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:16 INFO - 'PWD': '/builds/slave/test', 06:35:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:16 INFO - 'RUST_BACKTRACE': 'full', 06:35:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:35:16 INFO - 'SHELL': '/bin/bash', 06:35:16 INFO - 'SHLVL': '1', 06:35:16 INFO - 'TERM': 'linux', 06:35:16 INFO - 'TMOUT': '86400', 06:35:16 INFO - 'USER': 'cltbld', 06:35:16 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557', 06:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:16 INFO - '_': '/tools/buildbot/bin/python'} 06:35:16 INFO - TEST-INFO | started process 19456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sHcGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:16 INFO - PID 19456 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:35:17 INFO - PID 19456 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:35:17 INFO - PID 19456 | 06:35:17 INFO - PID 19456 | (/builds/slave/test/build/application/firefox/firefox:19514): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:35:17 INFO - PID 19456 | 06:35:27 INFO - PID 19456 | RSS: Main: 188420096 06:35:27 INFO - PID 19456 | 06:35:30 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36941/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:31 INFO - PID 19456 | RSS: Main: 186757120 06:35:31 INFO - PID 19456 | 06:35:33 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36941/tests/kraken/driver.html?testName=audio-dft) 06:35:34 INFO - PID 19456 | RSS: Main: 186875904 06:35:34 INFO - PID 19456 | 06:35:37 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36941/tests/kraken/driver.html?testName=audio-fft) 06:35:38 INFO - PID 19456 | RSS: Main: 184320000 06:35:38 INFO - PID 19456 | 06:35:40 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36941/tests/kraken/driver.html?testName=audio-oscillator) 06:35:40 INFO - PID 19456 | RSS: Main: 183877632 06:35:40 INFO - PID 19456 | 06:35:43 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:43 INFO - PID 19456 | RSS: Main: 183750656 06:35:43 INFO - PID 19456 | 06:35:47 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36941/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:47 INFO - PID 19456 | RSS: Main: 187289600 06:35:47 INFO - PID 19456 | 06:35:51 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36941/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:51 INFO - PID 19456 | RSS: Main: 187142144 06:35:51 INFO - PID 19456 | 06:35:54 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36941/tests/kraken/driver.html?testName=json-parse-financial) 06:35:55 INFO - PID 19456 | RSS: Main: 187437056 06:35:55 INFO - PID 19456 | 06:35:57 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:57 INFO - PID 19456 | RSS: Main: 186855424 06:35:57 INFO - PID 19456 | 06:35:59 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:36:00 INFO - PID 19456 | RSS: Main: 185360384 06:36:00 INFO - PID 19456 | 06:36:02 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:36:02 INFO - PID 19456 | RSS: Main: 184262656 06:36:02 INFO - PID 19456 | 06:36:05 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:36:06 INFO - PID 19456 | RSS: Main: 185434112 06:36:06 INFO - PID 19456 | 06:36:09 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:36:09 INFO - PID 19456 | RSS: Main: 185372672 06:36:09 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | Cycle 1(1): loaded http://localhost:36941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36941/tests/kraken/driver.html?testName=ai-astar) 06:36:11 INFO - PID 19456 | RSS: Main: 186019840 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | __start_tp_report 06:36:11 INFO - PID 19456 | _x_x_mozilla_page_load 06:36:11 INFO - PID 19456 | _x_x_mozilla_page_load_details 06:36:11 INFO - PID 19456 | |i|pagename|runs| 06:36:11 INFO - PID 19456 | |0;ai-astar;114;107;108;107;108;105;118;109;109;106 06:36:11 INFO - PID 19456 | |1;audio-beat-detection;118;114;124;118;146;127;125;124;118;119 06:36:11 INFO - PID 19456 | |2;audio-dft;165;166;166;173;162;174;166;164;162;165 06:36:11 INFO - PID 19456 | |3;audio-fft;77;78;79;74;80;79;77;74;73;73 06:36:11 INFO - PID 19456 | |4;audio-oscillator;80;80;82;84;79;86;83;80;80;88 06:36:11 INFO - PID 19456 | |5;imaging-gaussian-blur;114;114;120;115;113;115;114;122;117;116 06:36:11 INFO - PID 19456 | |6;imaging-darkroom;156;153;147;147;147;150;155;150;155;150 06:36:11 INFO - PID 19456 | |7;imaging-desaturate;97;95;94;98;101;98;96;96;97;95 06:36:11 INFO - PID 19456 | |8;json-parse-financial;54;57;60;52;54;56;55;51;54;53 06:36:11 INFO - PID 19456 | |9;json-stringify-tinderbox;38;43;43;46;43;38;38;39;43;42 06:36:11 INFO - PID 19456 | |10;stanford-crypto-aes;80;75;76;87;76;80;78;76;81;81 06:36:11 INFO - PID 19456 | |11;stanford-crypto-ccm;121;119;114;129;114;113;113;124;113;116 06:36:11 INFO - PID 19456 | |12;stanford-crypto-pbkdf2;177;167;170;165;177;166;165;174;174;175 06:36:11 INFO - PID 19456 | |13;stanford-crypto-sha256-iterative;63;63;69;67;64;65;65;65;67;67 06:36:11 INFO - PID 19456 | __end_tp_report 06:36:11 INFO - PID 19456 | __start_cc_report 06:36:11 INFO - PID 19456 | _x_x_mozilla_cycle_collect,717 06:36:11 INFO - PID 19456 | __end_cc_report 06:36:11 INFO - PID 19456 | __startTimestamp1505655371798__endTimestamp 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | ------- Summary: start ------- 06:36:11 INFO - PID 19456 | Number of tests: 14 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#0] ai-astar Cycles:10 Average:109.10 Median:108.50 stddev:3.96 (3.6%) stddev-sans-first:3.78 06:36:11 INFO - PID 19456 | Values: 114.0 107.0 108.0 107.0 108.0 105.0 118.0 109.0 109.0 106.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:124.00 stddev:8.96 (7.2%) stddev-sans-first:9.29 06:36:11 INFO - PID 19456 | Values: 118.0 114.0 124.0 118.0 146.0 127.0 125.0 124.0 118.0 119.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.00 stddev:4.08 (2.5%) stddev-sans-first:4.30 06:36:11 INFO - PID 19456 | Values: 165.0 166.0 166.0 173.0 162.0 174.0 166.0 164.0 162.0 165.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#3] audio-fft Cycles:10 Average:76.40 Median:77.50 stddev:2.67 (3.5%) stddev-sans-first:2.83 06:36:11 INFO - PID 19456 | Values: 77.0 78.0 79.0 74.0 80.0 79.0 77.0 74.0 73.0 73.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:82.50 stddev:3.01 (3.6%) stddev-sans-first:3.09 06:36:11 INFO - PID 19456 | Values: 80.0 80.0 82.0 84.0 79.0 86.0 83.0 80.0 80.0 88.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:115.50 stddev:2.91 (2.5%) stddev-sans-first:2.99 06:36:11 INFO - PID 19456 | Values: 114.0 114.0 120.0 115.0 113.0 115.0 114.0 122.0 117.0 116.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:3.53 (2.3%) stddev-sans-first:3.24 06:36:11 INFO - PID 19456 | Values: 156.0 153.0 147.0 147.0 147.0 150.0 155.0 150.0 155.0 150.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:2.00 (2.1%) stddev-sans-first:2.12 06:36:11 INFO - PID 19456 | Values: 97.0 95.0 94.0 98.0 101.0 98.0 96.0 96.0 97.0 95.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:2.59 (4.8%) stddev-sans-first:2.74 06:36:11 INFO - PID 19456 | Values: 54.0 57.0 60.0 52.0 54.0 56.0 55.0 51.0 54.0 53.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#9] json-stringify-tinderbox Cycles:10 Average:41.30 Median:43.00 stddev:2.83 (6.6%) stddev-sans-first:2.74 06:36:11 INFO - PID 19456 | Values: 38.0 43.0 43.0 46.0 43.0 38.0 38.0 39.0 43.0 42.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:80.00 stddev:3.62 (4.5%) stddev-sans-first:3.82 06:36:11 INFO - PID 19456 | Values: 80.0 75.0 76.0 87.0 76.0 80.0 78.0 76.0 81.0 81.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:117.50 stddev:5.54 (4.7%) stddev-sans-first:5.74 06:36:11 INFO - PID 19456 | Values: 121.0 119.0 114.0 129.0 114.0 113.0 113.0 124.0 113.0 116.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:174.00 stddev:4.94 (2.8%) stddev-sans-first:4.74 06:36:11 INFO - PID 19456 | Values: 177.0 167.0 170.0 165.0 177.0 166.0 165.0 174.0 174.0 175.0 06:36:11 INFO - PID 19456 | 06:36:11 INFO - PID 19456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.96 (3.0%) stddev-sans-first:1.86 06:36:11 INFO - PID 19456 | Values: 63.0 63.0 69.0 67.0 64.0 65.0 65.0 65.0 67.0 67.0 06:36:11 INFO - PID 19456 | -------- Summary: end -------- 06:36:11 INFO - PID 19456 | 06:36:12 INFO - PID 19456 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:36:12 INFO - TEST-INFO | 19456: exit 0 06:36:12 INFO - TEST-OK | kraken | took 62806ms 06:36:12 INFO - SUITE-END | took 1175s 06:36:12 INFO - Completed test suite (00:19:35) 06:36:12 INFO - javascript benchmark 06:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8529.162721643432, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.6566177720456, 3151.4484965131096, 3153.826539540326, 3154.227214332489, 3154.3375891062874, 6060.030395136779, 6196.504279657623, 6260.906086408708, 6278.2779980302275, 6281.277653069898, 6160.045192995093, 6194.907076393858, 6200.78297259596, 6211.223597050369, 6219.595726277788, 5651.208830763697, 5696.9745445819735, 5753.510951569122, 5788.18965344852, 5871.941280587203, 5741.19623252745, 5778.971105144468, 5807.332156801958, 5812.0119579671555, 5833.445822646841, 47.71254017176514, 5224.052307633303, 5524.696141712204, 5591.3569939456875, 5719.28508936383, 5627.831165065055, 5634.859128521779, 5665.291838520185, 5669.489745922846, 5683.9715801420725, 5577.944220557783, 5584.553235741171, 5604.607677462579, 5624.690642014688, 5626.774929002835, 6124.479419249369, 6180.505559555269, 6180.81457556274, 6205.906911396332, 6236.03341482071, 6555.508336874754, 6575.046618240328, 6683.365080317362, 6687.665616719145, 6689.6989635466525, 6550.115734375846, 6602.504812139109, 6616.603003819786, 6702.631355275458, 6711.362420570038, 6145.477634401082, 6183.1034499997695, 6258.937410625881, 6273.654948977804, 6282.560220784547, 6855.931440685629, 6946.305369463013, 6953.061336719579, 6957.06079679247, 6961.930380696128, 6537.215534135839, 6572.539922205496, 6581.80254592363, 6616.801495955129, 6624.0395142705, 6455.4835613150835, 6594.472442204708, 6601.174853143357, 6603.0, 6607.636579988147, 6510.18622672166, 6527.2167339919515, 6562.343765623495, 6567.146270984741, 6570.244421891448, 6471.7734879279, 6540.215174179129, 6573.704183311763, 6591.967040164865, 6610.0745895574655, 5152.407473140637, 5296.3379577552805, 5298.867528311823, 5308.442613525602, 5333.0, 4560.065186636732, 4641.791119399635, 4666.766661666903, 4678.906421871544, 4680.695754775928, 5710.343310519261, 5739.713014349266, 5750.712464376765, 5808.419158084158, 5836.7957121501395, 6470.417662410406, 6612.834679132964, 6639.535232533773, 6645.900311495331, 6650.467962562983, 5618.4662457066515, 5675.659460432387, 5682.886342273214, 5728.541716662657, 5821.0, 5749.080147176432, 5787.71061446926, 5788.594798364074, 5797.826065218051, 5799.88400231993, 6488.480921526267, 6517.120188774549, 6583.572067815577, 6588.242352129567, 6591.0, 6400.135981642418, 6512.6092434454085, 6515.413612774873, 6569.9014514783275, 6589.143411356589, 6432.0, 6451.774187903401, 6454.322296158835, 6457.321981191907, 6457.61254324742, 6445.355464453517, 6480.740770369132, 6491.221053473613, 6511.869762604816, 6513.641749703812, 5697.158876275079, 6593.340665933369, 6620.801375958729, 6647.135872336566, 6745.898811517929, 6471.708773105316, 6480.513961453004, 6482.611043337415, 6556.803295901131, 6564.80305590833, 6225.0, 6410.775622853178, 6452.35476452351, 6545.5090868184125, 6573.079768832272, 6323.241211054703, 6370.267419246846, 6414.61512309263, 6427.678616069272, 6448.226212854487, 6541.443977261986, 6554.213494380705, 6560.901586476111, 6568.047633093271, 6587.4071333580205, 6265.0, 6312.0, 6327.936720632735, 6377.266614339224, 6393.744250230125], "value": 6005.47173119805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.5590748718154, 882.4176043811086, 883.461088735871, 887.2680038967853, 888.2006194425016, 38467.61532384675, 41462.37806432902, 41661.375079373836, 41748.791256043674, 41855.16289674205, 38340.0, 38553.421698674545, 38586.22827543448, 38647.0, 38665.61334386655, 6991.930080699191, 7111.53775004623, 7122.679479423413, 7140.535865168773, 7145.464090193231, 7080.150381954173, 7099.183593886692, 7105.609191494465, 7107.6090815005155, 7182.46131540134, 7055.682494287769, 7070.717171313141, 7071.398931090837, 7131.89302160468, 7132.85734285314, 6988.301169883021, 7638.541687498768, 7844.843103137905, 7858.1356050834365, 7879.487833290817, 7752.418568607321, 7768.689252429896, 7827.530348179127, 7856.0, 7867.095284042294, 37683.62316376856, 38047.23905521874, 38090.0, 38218.0, 38494.80752596219, 3561.0919215600115, 3584.5160903277983, 3584.8207589620674, 3585.049961760136, 3609.7653652512763, 32404.351912961843, 32487.83756081228, 32551.348973020406, 32554.02337929866, 32606.83696581502, 5082.364704411949, 5273.419923808378, 5278.1291086970605, 5303.124984377573, 5385.5960802939935, 167970.0, 178855.9999999987, 180177.0, 180652.0, 181935.09032454886, 40852.79573602113, 42281.57718422838, 47483.52516474791, 47689.76155119202, 47848.52151478441, 50477.74761126171, 51858.74070629623, 51876.48123518792, 51886.0, 52048.47951520512, 16309.592260193353, 16553.420630277884, 16584.419545315857, 16690.248938797784, 16718.164091795363, 13684.452621895012, 13688.178709277476, 13705.794413083811, 13739.106958047694, 13756.0, 13905.192324997888, 13913.860861391458, 13994.580162595139, 14014.159150451005, 14051.78922316166, 5429.104197807396, 5440.510354068153, 5556.333240011225, 5617.129344951539, 5619.325680918316, 986.7385142937128, 1015.2537884654773, 1018.4042335233971, 1037.5331101004579, 1041.3595638682157, 23886.0, 23929.64105538418, 23970.0, 24163.275101746975, 24319.239923952715, 1107.0977153619774, 1132.8753837077916, 1149.1553708024596, 1151.9424028798526, 1160.5415860735131, 12685.873141268654, 12712.42794074269, 12753.872461275454, 12833.165844220095, 12939.288339141249, 225048.0, 225282.0, 225378.0, 226229.0, 226893.0, 53130.0, 53448.0, 53458.732706336996, 53801.46198537965, 53870.0, 1387.8681525255085, 1447.6815100677834, 1472.8465726650957, 1478.4529724001973, 1481.2445652716976, 22841.428964276027, 22927.197548085736, 23192.652110218696, 23205.0, 23720.0, 37859.0, 37930.241395172496, 37939.05152371213, 38013.239735205694, 38016.619833801306, 192935.0, 193642.0, 193773.0, 194033.0, 195555.0, 30825.0, 34698.0, 34953.65046349606, 35017.474737879464, 35532.0, 44344.334834978144, 44878.0, 45033.77483112564, 45203.77398112988, 45667.54332456766, 32205.677943220267, 32606.673933260365, 32896.342073158885, 33002.17494562655, 33635.0, 32128.518072228468, 32254.35491290114, 32435.513467297536, 32582.185445364055, 32616.510752338258, 36181.81909090438, 36244.1932332471, 36334.27331453409, 36551.0, 36752.44871326879, 31502.369952600362, 31793.364132717677, 32205.194870128435, 32214.35571288608, 32463.18842028968, 23831.761682383647, 23951.880240598686, 24431.38921526976, 24544.877275613508, 24600.384990375383], "value": 17119.97622812739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7820749907539, 561.278756797515, 562.558391662545, 584.514852672282, 599.364673446147, 22191.334259972187, 22895.42761430963, 23125.421864453398, 23152.536949261004, 23214.88392558037, 23730.16944406942, 24603.63094553583, 24688.0, 24881.87559062207, 25314.74685253147, 6448.645324507139, 6578.60528368297, 6581.045748366508, 6581.210254769434, 6625.370589793962, 6429.8714025719455, 6490.221173459192, 6548.345165483461, 6550.770723024695, 6553.50848686348, 6154.384561543855, 6416.935830641703, 6418.454431373339, 6432.13166222561, 6481.837954051163, 6356.014817703263, 6387.265464471576, 6387.489000879942, 6423.132877061584, 6428.742850285983, 5968.283805943314, 5984.281886173643, 5986.6707331097205, 6008.218931538916, 6444.613323200623, 30118.0, 30808.537871931938, 30816.691833081608, 30947.381052379053, 30973.22566935822, 2134.6371116910163, 2148.473623962124, 2151.376100930728, 2157.719496465465, 2174.402039439151, 19974.0, 20349.18603255868, 20660.380188594365, 20702.58594828095, 21322.893385533127, 2568.845869247851, 2604.5832666773413, 2661.3745769744096, 2665.3869609989615, 2673.6123262126885, 125195.0, 131882.34058829644, 132353.3382333092, 133046.33476832652, 141603.29198354046, 20123.496912577302, 20423.0, 20429.0, 21283.0, 21316.78683213179, 41783.1643367137, 41900.790496047935, 42036.57963420327, 42222.15555688869, 42275.15449690989, 10655.680329590125, 10689.572417103229, 10823.350598964087, 10834.916508349103, 10898.782024359627, 8995.235404990519, 9017.63929442828, 9060.592273347715, 9165.725028249164, 9171.174594286413, 10750.677479675622, 10811.513481893177, 10832.566697332177, 11102.777944441228, 11463.656090317303, 3640.9453858192146, 4010.418489319091, 4199.307114326163, 4250.553691862372, 4423.889402764892, 965.932384733076, 968.4237878462303, 978.3836183204678, 980.0, 983.7491439682835, 18680.0, 18882.150303236387, 19389.0, 19457.513562160777, 19571.315003974792, 1043.4678314059884, 1046.267612671118, 1057.5505410200633, 1060.3372891942536, 1062.654637242899, 10563.947180264204, 10711.83932241017, 10716.892831071746, 10736.546878196892, 10739.463026848782, 479528.0, 486905.0, 486954.3071161049, 488685.0, 490512.0, 108336.0, 109194.0, 110121.0, 111392.0, 112965.43517282525, 1153.2273376837538, 1158.6813626252847, 1178.8113901775675, 1198.4846515998204, 1200.327816422806, 16927.496334420422, 16933.915330423268, 17053.57366065858, 17103.657926841643, 17114.315427382764, 53910.0, 54902.72548637391, 55306.72346638402, 55480.44519554753, 56088.71955640196, 68080.3191968074, 68185.3181468179, 68324.0, 69392.3060769406, 69455.65272173607, 18234.908825455786, 19637.0, 19738.111784969424, 19782.90108549448, 19906.800931991074, 22167.33497995063, 22437.43906402353, 22440.43898902475, 22512.32463026112, 22936.88531557398, 18052.458426247234, 18156.27374905042, 18253.361132360835, 18285.81714182841, 18291.634167316846, 16124.596885077966, 16398.09810460436, 16457.835421645632, 16597.004179749252, 16749.832501674828, 18288.0, 18385.90807045956, 18416.539586510444, 18452.63094738071, 18792.0, 17763.911180444014, 18930.0, 19012.524686882385, 19021.048947552845, 19185.61628767445, 17550.06772324899, 17599.29602815873, 17603.55991100233, 17617.383391581232, 17662.64674706473], "value": 12622.019880757245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.8135570342301, 1369.7534443800116, 1408.2114016150956, 1411.3719394869288, 1414.5968399006285, 14572.781408278872, 15197.24013799311, 15198.240087995597, 15200.771988420183, 15216.543503694878, 14905.32926018329, 14992.0, 15021.474248401308, 15024.549263522085, 15104.622384440367, 2569.974300256992, 2570.100464837306, 2621.750933661309, 2636.736326367367, 2642.9735702643015, 2602.154299852546, 2624.619430182622, 2651.4431969286375, 2652.376691477501, 2656.256248250483, 2717.877695503707, 2741.3420779012995, 2752.545829938058, 2805.3126983888974, 2837.6027356170152, 2800.4679110968955, 2836.61705669734, 2839.346950201465, 2843.772498200139, 2844.886204551826, 2551.5917453207585, 2553.0681301325067, 2560.129555950986, 2586.728393518691, 2587.32729490332, 14166.645833854132, 14847.406103755944, 15337.46318878845, 15408.691826163526, 15476.613084672974, 8100.392470564731, 8417.705380311721, 8420.368472364597, 8424.283935865458, 8426.283765879907, 5325.281087053237, 5413.891722165535, 5514.255575497336, 5523.2543606613, 5571.721413929287, 1819.3995981326132, 1855.749473821044, 1889.5559543507266, 1905.6284024615206, 1907.542189874434, 25988.480230395475, 26518.602220966703, 26561.0, 26615.866920665467, 26646.0, 7276.345128938421, 7297.664747280819, 7323.157836848831, 7454.366378857858, 7501.649703053394, 20060.09729562144, 20076.09657565413, 20120.798792011894, 20121.899390502953, 20133.597328053358, 8235.547044912588, 8402.075771665111, 8403.07566167721, 8405.873911891327, 8413.621387037598, 7218.45861560385, 7440.3675687567165, 7451.403887688972, 7482.027336446227, 7510.924890751132, 5445.83662490126, 5634.915476267777, 5699.145128230799, 5706.343770466367, 5797.971010144923, 1745.642143360608, 1800.9549761256073, 1806.2774890044088, 1835.5686413692772, 1858.3960212930851, 879.2262808728278, 899.5322432335149, 901.4816480523725, 916.0381599320687, 921.0145144695246, 7620.961895190489, 7626.122995855437, 7640.80897977555, 7656.0, 7717.961410193026, 719.665355609644, 720.1610124205347, 721.7654262364753, 727.3599232675211, 743.4201322968094, 4412.602865742098, 4555.612772914273, 4581.518940511265, 5087.236914462786, 5230.372355317386, 20045.899770501055, 20853.37439876806, 20882.79117208839, 21352.893235534033, 21650.0, 20295.695564566544, 20408.795912040987, 20530.07614657344, 21284.574308513744, 21591.892040539697, 10970.561177552809, 11011.779764404668, 11037.282576632653, 11121.443927803577, 11267.54929802815, 8219.178082191733, 8483.151684831468, 8620.267277281502, 8657.134286571292, 8661.956690216508, 18055.729164062286, 18123.0, 18680.906595466935, 18800.7179892299, 19070.904645476683, 18806.0, 19207.903960480107, 19551.511212219808, 19605.31381401644, 19780.40658780239, 12002.579909703118, 12043.277403355827, 12110.394480276127, 12129.272243665408, 12138.696532586757, 13875.930620346833, 13882.375293112036, 13976.650583735487, 14045.227512486912, 14107.153570785786, 10403.895961040293, 10409.0, 10658.360498369813, 10767.138628909825, 10858.45707714627, 10737.892621074001, 10793.190510711886, 10923.890761092605, 10926.344419334866, 11171.944140279247, 9565.904340956502, 9677.564509597225, 9692.612295508383, 9705.417674939526, 9720.805583888141, 6958.79123626292, 6974.546654467444, 7019.3682568569075, 7037.225905150532, 7050.788476345718, 6943.652817359213, 7145.214026456982, 7189.712411503481, 7242.855142897007, 7326.4138868889295], "value": 6672.333558220693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.2810353091548, 502.6501107323264, 523.1470221816321, 528.3870709976428, 533.1469648562299, 6196.752129914798, 6201.287021863388, 6234.220722409699, 6264.874702505947, 6326.968365158179, 6115.663638499881, 6141.692915354226, 6151.569390142692, 6173.691315434233, 6260.154879091321, 5085.982803439309, 5118.155504341779, 5157.638965272433, 5171.974140129313, 5178.48215178481, 5174.948250517485, 5182.766775495112, 5185.688858668492, 5225.335079109663, 5236.92144617831, 4727.787249573777, 4906.681065730734, 5030.245463180534, 5102.489751024905, 5106.69359838409, 4874.65877388583, 4893.75531223441, 4899.093667671475, 4914.533119353674, 4943.555080042777, 4351.456067991501, 4380.233459144637, 4380.978095109536, 4386.956130438687, 4398.670099742532, 5879.412058794129, 6032.396760323976, 6050.878982420327, 6137.110119032715, 6140.570160088796, 5638.689872057035, 5666.433356664342, 5694.316681998145, 5706.315242170925, 5708.885822283572, 6409.3590640936, 6471.288158302583, 6482.7406903723795, 6509.739610415578, 6519.804405867784, 4640.744759038252, 4804.183288840905, 4814.542618451242, 4838.346823178861, 4841.0, 6569.80290591283, 6701.597904125768, 6710.530262881552, 6711.731530738764, 6751.797446076625, 4883.536064073907, 4892.926606100911, 4933.728644924492, 4944.554990050912, 4945.9258111128365, 4944.258361245842, 4981.302617633534, 5002.0, 5011.473795251446, 5012.724300163453, 5523.392426833045, 5544.63959842609, 5610.382857885629, 5622.128570071645, 5650.717464126859, 6476.481881449473, 6520.630667559865, 6538.8365290868105, 6572.507061970371, 6578.63817490033, 1729.5330260829505, 1734.167599552222, 1741.9912900435418, 1751.9737203941952, 1764.1443899708631, 1123.7078359626391, 1204.9698757531132, 1209.6673414810998, 1211.5396149463147, 1213.3447938113497, 5580.832575022756, 5652.9152062719095, 5663.292088488939, 5684.63049901755, 5715.685637289906, 6560.343965603402, 6600.60396376219, 6606.306337834554, 6633.635150066792, 6656.101426307483, 5579.637323573955, 5605.467480589337, 5622.91565626516, 5665.801696940587, 5702.771889124471, 3446.7070299024363, 3448.74134439913, 3491.1970246843366, 3498.422760244531, 3533.8056406897354, 6229.5327850410495, 6300.432961033529, 6368.713407896656, 6405.19935008124, 6445.0, 6617.371349721769, 6625.3374662534325, 6678.198616166092, 6694.933050669529, 6704.363085506967, 6416.262129855033, 6445.484361251089, 6490.513211509156, 6495.960646296664, 6533.575317604531, 6081.726322315418, 6506.4469520091325, 6553.4611309892125, 6604.3725846044545, 6616.437602803623, 6465.191851018622, 6479.347766319747, 6485.805425837232, 6492.577982431127, 6508.251551071688, 6323.810285691437, 6362.268339141058, 6392.360763923756, 6392.4246817786625, 6399.55203135776, 4939.110960027229, 5236.653577530565, 5405.9459405407015, 5435.809746659006, 5449.6730196188355, 6278.215223097113, 6295.18162638854, 6410.423061924449, 6572.7042283098335, 6710.328967103251, 6312.936870631235, 6314.715837787402, 6440.484761218998, 6440.516961227833, 6537.738490460519, 6265.467435268053, 6325.0, 6351.301356850835, 6428.100065990859, 6485.0, 6216.160818289473, 6274.874502510015, 6321.715522801393, 6337.873242535031, 6356.364363563606, 6481.967590162019, 6517.250516190698, 6532.477401807939, 6534.444572211415, 6555.115059467102, 6228.34602366745, 6262.2172228471445, 6279.215098112736, 6287.402696743802, 6345.8730825384155], "value": 5001.800966127025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.2174886100231, 915.0, 928.5125309212663, 931.1573026411096, 944.5796620503876, 18829.529261768446, 19610.803891961077, 19619.70570441441, 19682.803171968277, 19706.80293197066, 16925.59076168154, 17440.912795436005, 17594.384196553125, 19119.426417207473, 19624.705629415534, 965.0879918477025, 973.4694591447643, 988.5650313861878, 989.3272574649236, 989.4310771306491, 989.7575094101956, 1002.6540843409012, 1003.2124782046095, 1006.9395836249812, 1007.9748006299828, 1016.806806706727, 1044.9216308776834, 1055.1347894726289, 1058.0, 1058.9682309530726, 1019.0, 1027.0961553832578, 1027.1628622672497, 1029.521272608237, 1040.7970445763078, 747.9962600187018, 748.2367984655621, 751.8195633048084, 751.9285667861544, 757.6666266842572, 20044.398668039983, 20107.095180716755, 20425.69361459579, 20428.897855510775, 20442.38672839817, 21859.125634974742, 22084.11663533457, 22253.888730556242, 22328.330150095524, 22386.55226895453, 17084.572885677833, 17186.57033574158, 17254.3960961367, 17297.567560810956, 17362.305507779674, 3692.3169213695282, 3724.981375093107, 3729.2914346274392, 3734.551853777537, 3744.101415660249, 136792.0, 137487.0, 138001.0, 138976.99999999898, 140533.0, 16750.664986700198, 16805.747913781302, 16907.492775216764, 16967.660646786993, 17100.914495427693, 32109.678903210668, 32186.83906580499, 32426.513602295985, 32485.0, 32513.0, 7919.089304729914, 7928.8810667840025, 7946.364290856717, 8056.677732890619, 8066.193380661887, 4431.711938723973, 4530.161920044802, 4536.0, 4546.636269098464, 4552.521985191507, 5391.811286605029, 5484.232207490954, 5490.80782172622, 5504.532114770209, 5513.807016754395, 914.8033172867865, 998.1615443027746, 1011.2567263061644, 1017.97455063624, 1019.1133713669155, 667.6828506459393, 681.7136802542844, 691.0084029417801, 692.9826754331182, 699.0876905638089, 11322.603708870314, 11500.773851291202, 11662.708432289091, 11999.820002699966, 12142.028637708961, 637.3499030988365, 637.7799659117597, 647.795944277551, 652.9347065293433, 665.0921492163162, 5591.384947655754, 5607.719614019365, 5613.106238449612, 5689.402612725604, 5778.075507918713, 117055.0, 119926.40036799935, 125293.0, 125729.0, 126467.0, 107953.4602326999, 109089.45455272673, 112357.0, 113376.0, 115679.0, 97354.51322743483, 97998.0, 98820.50589747149, 99117.0, 99363.50318248362, 10199.235057370579, 10270.845937311096, 10627.893721063, 10636.8936310639, 10639.361638301727, 42931.7853410731, 43003.0, 43977.0, 44393.0, 44879.32681009853, 53852.0, 55933.0, 56303.71848140733, 56983.0, 57480.425195747506, 15319.923400382926, 15703.842961570695, 15776.842231577537, 15808.0, 15931.761023584888, 16649.833501664827, 16935.66128677395, 16986.405475808286, 17035.574110647332, 17219.31122755076, 15641.608959776097, 15825.129617871127, 15902.443414480438, 15942.68114637724, 16181.4336498222, 13682.384292706653, 13796.0, 13808.585742427744, 13878.930605346908, 13926.651833703832, 15378.69242615119, 15405.0, 15457.227138643248, 15568.766468502756, 15913.681726365176, 11426.828597570877, 11658.300501969909, 11684.70788230301, 11890.405479726152, 11978.46096925658, 11495.425228738697, 11610.129240306842, 11635.127365447795, 11760.764784704086, 11938.0], "value": 8888.485157230789, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 108.0, 107.0, 108.0, 105.0, 118.0, 109.0, 109.0, 106.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 124.0, 118.0, 146.0, 127.0, 125.0, 124.0, 118.0, 119.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 173.0, 162.0, 174.0, 166.0, 164.0, 162.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 74.0, 80.0, 79.0, 77.0, 74.0, 73.0, 73.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 84.0, 79.0, 86.0, 83.0, 80.0, 80.0, 88.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 120.0, 115.0, 113.0, 115.0, 114.0, 122.0, 117.0, 116.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 147.0, 147.0, 147.0, 150.0, 155.0, 150.0, 155.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 98.0, 101.0, 98.0, 96.0, 96.0, 97.0, 95.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 60.0, 52.0, 54.0, 56.0, 55.0, 51.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 43.0, 43.0, 46.0, 43.0, 38.0, 38.0, 39.0, 43.0, 42.0], "value": 41.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 76.0, 87.0, 76.0, 80.0, 78.0, 76.0, 81.0, 81.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 114.0, 129.0, 114.0, 113.0, 113.0, 124.0, 113.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 167.0, 170.0, 165.0, 177.0, 166.0, 165.0, 174.0, 174.0, 175.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 69.0, 67.0, 64.0, 65.0, 65.0, 65.0, 67.0, 67.0], "value": 65.5, "unit": "score"}]}]} 06:36:13 INFO - Return code: 0 06:36:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:36:13 INFO - # TBPL SUCCESS # 06:36:13 INFO - Running post-action listener: _package_coverage_data 06:36:13 INFO - Running post-action listener: _resource_record_post_action 06:36:13 INFO - [mozharness: 2017-09-17 13:36:13.089986Z] Finished run-tests step (success) 06:36:13 INFO - Running post-run listener: _resource_record_post_run 06:36:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 6889472; Write bytes: 407527424; Read time: 1712; Write time: 359172 06:36:13 INFO - TinderboxPrint: CPU usage
13.3% 06:36:13 INFO - TinderboxPrint: I/O read bytes / time
6,889,472 / 1,712 06:36:13 INFO - TinderboxPrint: I/O write bytes / time
407,527,424 / 359,172 06:36:13 INFO - TinderboxPrint: CPU idle
8,251.3 (86.7%) 06:36:13 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 06:36:13 INFO - TinderboxPrint: Swap in / out
0 / 0 06:36:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74547200; Read time: 0; Write time: 61132 06:36:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:36:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6885376; Write bytes: 332980224; Read time: 1696; Write time: 298040 06:36:13 INFO - Running post-run listener: _upload_blobber_files 06:36:13 INFO - Blob upload gear active. 06:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:36:13 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 06:36:13 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'] 06:36:13 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 06:36:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:15 INFO - (blobuploader) - INFO - Done attempting. 06:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:21 INFO - (blobuploader) - INFO - Done attempting. 06:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:22 INFO - (blobuploader) - INFO - Done attempting. 06:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:23 INFO - (blobuploader) - INFO - Done attempting. 06:36:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:36:23 INFO - Return code: 0 06:36:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:36:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:36:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8055225943d09fa30a1616c7783c8cf3b4615c41670b18c29e0595ab82d99de177dc57903160ef92d16f76dd9048a0d23271388907ff38c20f5d9515340e7d7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44ea1a87190c9055dd11c116adf47458124fcb4dbae86eab2f39a3f122037933c605a5720dfb3ba604c7c1978bf32642d7c03daa8c9551858fbd70a939f1845", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2795c5954c408e08a2f8d3bf101c42188538cb4172fb4364463c18b8046d5984c5127f1efb99d60680ea400fb10b43421187b8958bf133a0febba3f48eed162f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23b1b5e163fbba5a209e573d78c9e4a01b0d4a30830192e77ce8d5d0a54c9a17f2d6b68c8db65b5ad22c374dc9f695869e97cf662c3791150ae85ab1d3609546"} 06:36:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:36:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:36:23 INFO - Contents: 06:36:23 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8055225943d09fa30a1616c7783c8cf3b4615c41670b18c29e0595ab82d99de177dc57903160ef92d16f76dd9048a0d23271388907ff38c20f5d9515340e7d7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44ea1a87190c9055dd11c116adf47458124fcb4dbae86eab2f39a3f122037933c605a5720dfb3ba604c7c1978bf32642d7c03daa8c9551858fbd70a939f1845", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2795c5954c408e08a2f8d3bf101c42188538cb4172fb4364463c18b8046d5984c5127f1efb99d60680ea400fb10b43421187b8958bf133a0febba3f48eed162f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23b1b5e163fbba5a209e573d78c9e4a01b0d4a30830192e77ce8d5d0a54c9a17f2d6b68c8db65b5ad22c374dc9f695869e97cf662c3791150ae85ab1d3609546"} 06:36:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:36:23 INFO - Copying logs to upload dir... 06:36:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:36:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.090837 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-17 06:36:23.858921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 06:36:23.865554) ========= 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=9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557 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/d8055225943d09fa30a1616c7783c8cf3b4615c41670b18c29e0595ab82d99de177dc57903160ef92d16f76dd9048a0d23271388907ff38c20f5d9515340e7d7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44ea1a87190c9055dd11c116adf47458124fcb4dbae86eab2f39a3f122037933c605a5720dfb3ba604c7c1978bf32642d7c03daa8c9551858fbd70a939f1845", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2795c5954c408e08a2f8d3bf101c42188538cb4172fb4364463c18b8046d5984c5127f1efb99d60680ea400fb10b43421187b8958bf133a0febba3f48eed162f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23b1b5e163fbba5a209e573d78c9e4a01b0d4a30830192e77ce8d5d0a54c9a17f2d6b68c8db65b5ad22c374dc9f695869e97cf662c3791150ae85ab1d3609546"} build_url:https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/Wjb9bWClSh6PQEiCFFxuzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8055225943d09fa30a1616c7783c8cf3b4615c41670b18c29e0595ab82d99de177dc57903160ef92d16f76dd9048a0d23271388907ff38c20f5d9515340e7d7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44ea1a87190c9055dd11c116adf47458124fcb4dbae86eab2f39a3f122037933c605a5720dfb3ba604c7c1978bf32642d7c03daa8c9551858fbd70a939f1845", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2795c5954c408e08a2f8d3bf101c42188538cb4172fb4364463c18b8046d5984c5127f1efb99d60680ea400fb10b43421187b8958bf133a0febba3f48eed162f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23b1b5e163fbba5a209e573d78c9e4a01b0d4a30830192e77ce8d5d0a54c9a17f2d6b68c8db65b5ad22c374dc9f695869e97cf662c3791150ae85ab1d3609546"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 06:36:23.900024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 06:36:23.904462) ========= 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=9bfb7e13875ed353a705960e000001c0-1505652468.136454-753786557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 06:36:23.984178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 06:36:23.984506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 06:36:23.984844) ========= ========= Total master_lag: 0.45 =========