builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1505557344.84 results: success (0) revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:24.840932) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:24.844587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:24.844876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:24.893457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:24.893757) ========= 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=cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:22:24-- 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% 39.2M=0s 2017-09-16 03:22:24 (39.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134480 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.060374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.060650) ========= 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=cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016148 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.129125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-16 03:22:25.129448) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 --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 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 --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=cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:22:25,103 truncating revision to first 12 chars 2017-09-16 03:22:25,103 Setting DEBUG logging. 2017-09-16 03:22:25,104 attempt 1/10 2017-09-16 03:22:25,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6c1b45e7e94d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:22:25,810 sleeping for 11.00s (attempt 1/10) 2017-09-16 03:22:36,821 attempt 2/10 2017-09-16 03:22:36,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6c1b45e7e94d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:22:37,458 unpacking tar archive at: mozilla-central-6c1b45e7e94d/testing/mozharness/ program finished with exit code 0 elapsedTime=12.639751 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-16 03:22:37.792208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.792532) ========= script_repo_revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.792929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.793190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.806649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-16 03:22:37.806985) ========= /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=cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:37 INFO - MultiFileLogger online at 20170916 03:22:37 in /builds/slave/test 03:22:37 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 03:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:37 INFO - {'append_to_log': False, 03:22:37 INFO - 'base_work_dir': '/builds/slave/test', 03:22:37 INFO - 'blob_upload_branch': 'Firefox', 03:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:37 INFO - 'branch': 'Firefox', 03:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:37 INFO - 'code_coverage': False, 03:22:37 INFO - 'config_files': ('talos/linux_config.py',), 03:22:37 INFO - 'default_actions': ('clobber', 03:22:37 INFO - 'read-buildbot-config', 03:22:37 INFO - 'download-and-extract', 03:22:37 INFO - 'populate-webroot', 03:22:37 INFO - 'create-virtualenv', 03:22:37 INFO - 'install', 03:22:37 INFO - 'setup-mitmproxy', 03:22:37 INFO - 'run-tests'), 03:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:37 INFO - 'disable_ccov_upload': False, 03:22:37 INFO - 'disable_stylo': False, 03:22:37 INFO - 'download_minidump_stackwalk': True, 03:22:37 INFO - 'download_symbols': 'ondemand', 03:22:37 INFO - 'enable_stylo': False, 03:22:37 INFO - 'enable_webrender': False, 03:22:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:37 INFO - 'gecko_profile': False, 03:22:37 INFO - 'gecko_profile_interval': 0, 03:22:37 INFO - 'installer_path': 'installer.exe', 03:22:37 INFO - 'log_level': 'info', 03:22:37 INFO - 'log_name': 'talos', 03:22:37 INFO - 'log_to_console': True, 03:22:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:37 INFO - 'opt_config_files': (), 03:22:37 INFO - 'pip_index': False, 03:22:37 INFO - 'suite': 'dromaeojs-e10s', 03:22:37 INFO - 'system_bits': '32', 03:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:37 INFO - 'title': 'talos-linux64-ix-054', 03:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:37 INFO - 'use_talos_json': True, 03:22:37 INFO - 'verify': 'False', 03:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:37 INFO - 'work_dir': 'build'} 03:22:37 INFO - [mozharness: 2017-09-16 10:22:37.913902Z] Running clobber step. 03:22:37 INFO - Running pre-action listener: _resource_record_pre_action 03:22:37 INFO - Running main action method: clobber 03:22:37 INFO - rmtree: /builds/slave/test/build 03:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:39 INFO - Running post-action listener: _resource_record_post_action 03:22:39 INFO - [mozharness: 2017-09-16 10:22:39.443252Z] Finished clobber step (success) 03:22:39 INFO - [mozharness: 2017-09-16 10:22:39.443349Z] Running read-buildbot-config step. 03:22:39 INFO - Running pre-action listener: _resource_record_pre_action 03:22:39 INFO - Running main action method: read_buildbot_config 03:22:39 INFO - Using buildbot properties: 03:22:39 INFO - { 03:22:39 INFO - "project": "", 03:22:39 INFO - "product": "firefox", 03:22:39 INFO - "who": "archaeopteryx@coole-files.de", 03:22:39 INFO - "installer_path": "public/build/target.tar.bz2", 03:22:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:22:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:22:39 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:22:39 INFO - "stage_platform": "linux64-qr", 03:22:39 INFO - "basedir": "/builds/slave/test", 03:22:39 INFO - "buildnumber": 62, 03:22:39 INFO - "platform": "ubuntu64_hw_qr", 03:22:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:22:39 INFO - "slavebuilddir": "test", 03:22:39 INFO - "taskId": "CcAuVd1ORo2ZkODZRDAXMg", 03:22:39 INFO - "branch": "mozilla-central", 03:22:39 INFO - "script_repo_revision": "production", 03:22:39 INFO - "revision": "6c1b45e7e94dbf343813eda03f1fd0b3259b59b1", 03:22:39 INFO - "slavename": "talos-linux64-ix-054", 03:22:39 INFO - "repo_path": "mozilla-central" 03:22:39 INFO - } 03:22:39 INFO - Finding installer, test and symbols from parent task. 03:22:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcAuVd1ORo2ZkODZRDAXMg'}, attempt #1 03:22:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcAuVd1ORo2ZkODZRDAXMg'}, attempt #1 03:22:40 INFO - Task dependencies: HjCsUs2wRpaX7mNuomNYtQ 03:22:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ'}, attempt #1 03:22:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json 03:22:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip 03:22:40 INFO - Running post-action listener: _resource_record_post_action 03:22:40 INFO - [mozharness: 2017-09-16 10:22:40.812635Z] Finished read-buildbot-config step (success) 03:22:40 INFO - [mozharness: 2017-09-16 10:22:40.812850Z] Running download-and-extract step. 03:22:40 INFO - Running pre-action listener: _resource_record_pre_action 03:22:40 INFO - Running main action method: download_and_extract 03:22:40 INFO - mkdir: /builds/slave/test/build/tests 03:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:40 INFO - trying https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json 03:22:40 INFO - Downloading https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:22:41 INFO - Downloaded 989 bytes. 03:22:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:22:41 INFO - Using the following test package requirements: 03:22:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:22:41 INFO - u'common': [u'target.common.tests.zip'], 03:22:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:22:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:22:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:22:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:22:41 INFO - u'mozbase': [u'target.common.tests.zip'], 03:22:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:22:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:22:41 INFO - u'web-platform': [u'target.common.tests.zip', 03:22:41 INFO - u'target.web-platform.tests.tar.gz'], 03:22:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:22:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:22:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip 03:22:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:41 INFO - Fetch https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip into memory 03:22:42 INFO - Content-Length response header: 54731145 03:22:42 INFO - Bytes received: 54731145 03:22:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip 03:22:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:22:53 INFO - Fetch https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip into memory 03:22:53 INFO - Content-Length response header: 14508749 03:22:53 INFO - Bytes received: 14508749 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:54 INFO - trying https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:22:55 INFO - Downloaded 61438347 bytes. 03:22:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:55 INFO - mkdir: /builds/slave/test/properties 03:22:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:55 INFO - Contents: 03:22:55 INFO - build_url:https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:55 INFO - Running post-action listener: _resource_record_post_action 03:22:55 INFO - Running post-action listener: find_tests_for_verification 03:22:55 INFO - Running post-action listener: set_extra_try_arguments 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.425543Z] Finished download-and-extract step (success) 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.425676Z] Running populate-webroot step. 03:22:55 INFO - Running pre-action listener: _resource_record_pre_action 03:22:55 INFO - Running main action method: populate_webroot 03:22:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tresize', 03:22:55 INFO - 'tcanvasmark']}, 03:22:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['dromaeo_css', 03:22:55 INFO - 'kraken']}, 03:22:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'tests': ['damp', 'tps']}, 03:22:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['damp', 'tps']}, 03:22:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['dromaeo_dom']}, 03:22:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:22:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['basic_compositor_video', 03:22:55 INFO - 'glvideo']}, 03:22:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:22:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['ts_paint_webext', 03:22:55 INFO - 'tp5o_webext']}, 03:22:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:55 INFO - 'ts_paint', 03:22:55 INFO - 'tpaint', 03:22:55 INFO - 'sessionrestore', 03:22:55 INFO - 'sessionrestore_many_windows', 03:22:55 INFO - 'sessionrestore_no_auto_restore', 03:22:55 INFO - 'tabpaint']}, 03:22:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['a11yr', 03:22:55 INFO - 'ts_paint', 03:22:55 INFO - 'tpaint', 03:22:55 INFO - 'sessionrestore', 03:22:55 INFO - 'sessionrestore_many_windows', 03:22:55 INFO - 'sessionrestore_no_auto_restore', 03:22:55 INFO - 'tabpaint']}, 03:22:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:22:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:22:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['perf_reftest_singletons']}, 03:22:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['bloom_basic']}, 03:22:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:55 INFO - 'tsvgr_opacity', 03:22:55 INFO - 'tart', 03:22:55 INFO - 'tscrollx', 03:22:55 INFO - 'tsvg_static']}, 03:22:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tsvgx', 03:22:55 INFO - 'tsvgr_opacity', 03:22:55 INFO - 'tart', 03:22:55 INFO - 'tscrollx', 03:22:55 INFO - 'tsvg_static']}, 03:22:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:22:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tp5o']}, 03:22:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:55 INFO - 'talos_options': ['--mitmproxy', 03:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:55 INFO - '--firstNonBlankPaint'], 03:22:55 INFO - 'tests': ['tp6_google', 03:22:55 INFO - 'tp6_youtube', 03:22:55 INFO - 'tp6_amazon', 03:22:55 INFO - 'tp6_facebook']}, 03:22:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo', 03:22:55 INFO - '--mitmproxy', 03:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:55 INFO - '--firstNonBlankPaint'], 03:22:55 INFO - 'tests': ['tp6_google', 03:22:55 INFO - 'tp6_youtube', 03:22:55 INFO - 'tp6_amazon', 03:22:55 INFO - 'tp6_facebook']}, 03:22:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:55 INFO - 'talos_options': ['--stylo-threads=1', 03:22:55 INFO - '--mitmproxy', 03:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:55 INFO - '--firstNonBlankPaint'], 03:22:55 INFO - 'tests': ['tp6_google', 03:22:55 INFO - 'tp6_youtube', 03:22:55 INFO - 'tp6_amazon', 03:22:55 INFO - 'tp6_facebook']}, 03:22:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--xperf_path', 03:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:55 INFO - 'tests': ['tp5n']}, 03:22:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo', 03:22:55 INFO - '--xperf_path', 03:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:55 INFO - 'tests': ['tp5n']}}} 03:22:55 INFO - Running post-action listener: _resource_record_post_action 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.443229Z] Finished populate-webroot step (success) 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.443318Z] Running create-virtualenv step. 03:22:55 INFO - Running pre-action listener: _resource_record_pre_action 03:22:55 INFO - Running main action method: create_virtualenv 03:22:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:22:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:22:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:22:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:56 INFO - Installing pip...............done. 03:22:56 INFO - Return code: 0 03:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:22:56 INFO - Reading from file tmpfile_stdout 03:22:56 INFO - Output received: 03:22:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:22:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:22:56 INFO - Using env: {'DISPLAY': ':0', 03:22:56 INFO - 'HOME': '/home/cltbld', 03:22:56 INFO - 'LANG': 'en_US.UTF-8', 03:22:56 INFO - 'LANGUAGE': 'en_US:en', 03:22:56 INFO - 'LOGNAME': 'cltbld', 03:22:56 INFO - 'MAIL': '/var/mail/cltbld', 03:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:56 INFO - 'MOZ_NO_REMOTE': '1', 03:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:56 INFO - 'NO_EM_RESTART': '1', 03:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:56 INFO - 'PWD': '/builds/slave/test', 03:22:56 INFO - 'SHELL': '/bin/bash', 03:22:56 INFO - 'SHLVL': '1', 03:22:56 INFO - 'TERM': 'linux', 03:22:56 INFO - 'TMOUT': '86400', 03:22:56 INFO - 'USER': 'cltbld', 03:22:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:56 INFO - '_': '/tools/buildbot/bin/python'} 03:22:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:22:57 INFO - Downloading/unpacking pip>=1.5 03:22:57 INFO - Running setup.py egg_info for package pip 03:22:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:22:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:22:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:22:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:22:57 INFO - Installing collected packages: pip 03:22:57 INFO - Found existing installation: pip 1.1 03:22:57 INFO - Uninstalling pip: 03:22:57 INFO - Successfully uninstalled pip 03:22:57 INFO - Running setup.py install for pip 03:22:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:22:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:22:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:22:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:22:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:22:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:22:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:22:57 INFO - Successfully installed pip 03:22:57 INFO - Cleaning up... 03:22:57 INFO - Return code: 0 03:22:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:22:57 INFO - Using env: {'DISPLAY': ':0', 03:22:57 INFO - 'HOME': '/home/cltbld', 03:22:57 INFO - 'LANG': 'en_US.UTF-8', 03:22:57 INFO - 'LANGUAGE': 'en_US:en', 03:22:57 INFO - 'LOGNAME': 'cltbld', 03:22:57 INFO - 'MAIL': '/var/mail/cltbld', 03:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:57 INFO - 'MOZ_NO_REMOTE': '1', 03:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:57 INFO - 'NO_EM_RESTART': '1', 03:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:57 INFO - 'PWD': '/builds/slave/test', 03:22:57 INFO - 'SHELL': '/bin/bash', 03:22:57 INFO - 'SHLVL': '1', 03:22:57 INFO - 'TERM': 'linux', 03:22:57 INFO - 'TMOUT': '86400', 03:22:57 INFO - 'USER': 'cltbld', 03:22:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:57 INFO - '_': '/tools/buildbot/bin/python'} 03:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:58 INFO - Downloading/unpacking psutil>=3.1.1 03:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:59 INFO - Installing collected packages: psutil 03:22:59 INFO - Running setup.py install for psutil 03:22:59 INFO - building 'psutil._psutil_linux' extension 03:22:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:22:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:22:59 INFO - building 'psutil._psutil_posix' extension 03:22:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:22:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:59 INFO - Successfully installed psutil 03:22:59 INFO - Cleaning up... 03:22:59 INFO - Return code: 0 03:22:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22: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')]} 03:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:22: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 mozsystemmonitor==0.3 03:22:59 INFO - Using env: {'DISPLAY': ':0', 03:22:59 INFO - 'HOME': '/home/cltbld', 03:22:59 INFO - 'LANG': 'en_US.UTF-8', 03:22:59 INFO - 'LANGUAGE': 'en_US:en', 03:22:59 INFO - 'LOGNAME': 'cltbld', 03:22:59 INFO - 'MAIL': '/var/mail/cltbld', 03:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:59 INFO - 'MOZ_NO_REMOTE': '1', 03:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:59 INFO - 'NO_EM_RESTART': '1', 03:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:59 INFO - 'PWD': '/builds/slave/test', 03:22:59 INFO - 'SHELL': '/bin/bash', 03:22:59 INFO - 'SHLVL': '1', 03:22:59 INFO - 'TERM': 'linux', 03:22:59 INFO - 'TMOUT': '86400', 03:22:59 INFO - 'USER': 'cltbld', 03:22:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:59 INFO - '_': '/tools/buildbot/bin/python'} 03:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23: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 03:23: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 03:23: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 03:23: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 03:23:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:01 INFO - Installing collected packages: mozsystemmonitor 03:23:01 INFO - Running setup.py install for mozsystemmonitor 03:23:01 INFO - Successfully installed mozsystemmonitor 03:23:01 INFO - Cleaning up... 03:23:02 INFO - Return code: 0 03:23:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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', '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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:23: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 jsonschema==2.5.1 03:23:02 INFO - Using env: {'DISPLAY': ':0', 03:23:02 INFO - 'HOME': '/home/cltbld', 03:23:02 INFO - 'LANG': 'en_US.UTF-8', 03:23:02 INFO - 'LANGUAGE': 'en_US:en', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MAIL': '/var/mail/cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SHLVL': '1', 03:23:02 INFO - 'TERM': 'linux', 03:23:02 INFO - 'TMOUT': '86400', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - '_': '/tools/buildbot/bin/python'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:23: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 03:23: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 03:23: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 03:23: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 03:23:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23: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 03:23: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 03:23: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 03:23: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 03:23:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:05 INFO - warning: no files found matching '*.txt' 03:23:05 INFO - no previously-included directories found matching 'build' 03:23:05 INFO - no previously-included directories found matching 'dist' 03:23:05 INFO - no previously-included directories found matching '.git*' 03:23:05 INFO - Installing collected packages: jsonschema, functools32 03:23:05 INFO - Running setup.py install for functools32 03:23:05 INFO - warning: no files found matching '*.txt' 03:23:05 INFO - no previously-included directories found matching 'build' 03:23:05 INFO - no previously-included directories found matching 'dist' 03:23:05 INFO - no previously-included directories found matching '.git*' 03:23:05 INFO - Successfully installed jsonschema functools32 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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 03:23: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 03:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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', '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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23: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 blobuploader==1.2.4 03:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:23: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 03:23: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 03:23: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 03:23: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 03:23:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23: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 03:23: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 03:23: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 03:23: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 03:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23: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 03:23: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 03:23: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 03:23: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 03:23:07 INFO - Downloading docopt-0.6.1.tar.gz 03:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:07 INFO - Running setup.py install for blobuploader 03:23:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:07 INFO - Running setup.py install for requests 03:23:07 INFO - Running setup.py install for docopt 03:23:08 INFO - Successfully installed blobuploader requests docopt 03:23:08 INFO - Cleaning up... 03:23:08 INFO - Return code: 0 03:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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 03:23: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 03:23:08 INFO - Using env: {'DISPLAY': ':0', 03:23:08 INFO - 'HOME': '/home/cltbld', 03:23:08 INFO - 'LANG': 'en_US.UTF-8', 03:23:08 INFO - 'LANGUAGE': 'en_US:en', 03:23:08 INFO - 'LOGNAME': 'cltbld', 03:23:08 INFO - 'MAIL': '/var/mail/cltbld', 03:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:08 INFO - 'MOZ_NO_REMOTE': '1', 03:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:08 INFO - 'NO_EM_RESTART': '1', 03:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:08 INFO - 'PWD': '/builds/slave/test', 03:23:08 INFO - 'SHELL': '/bin/bash', 03:23:08 INFO - 'SHLVL': '1', 03:23:08 INFO - 'TERM': 'linux', 03:23:08 INFO - 'TMOUT': '86400', 03:23:08 INFO - 'USER': 'cltbld', 03:23:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:08 INFO - '_': '/tools/buildbot/bin/python'} 03:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:08 INFO - Running setup.py (path:/tmp/pip-KiZqx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:08 INFO - Running setup.py (path:/tmp/pip-bprCo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:08 INFO - Running setup.py (path:/tmp/pip-VKnuAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:08 INFO - Running setup.py (path:/tmp/pip-MfwG0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:08 INFO - Running setup.py (path:/tmp/pip-wycU1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:08 INFO - Running setup.py (path:/tmp/pip-SeDSTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:08 INFO - Running setup.py (path:/tmp/pip-93DeXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:08 INFO - Running setup.py (path:/tmp/pip-ThqqNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:08 INFO - Running setup.py (path:/tmp/pip-r3kb7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:08 INFO - Running setup.py (path:/tmp/pip-i9XF43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:09 INFO - Running setup.py (path:/tmp/pip-RpME7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:09 INFO - Running setup.py (path:/tmp/pip-1QYUXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:09 INFO - Running setup.py (path:/tmp/pip-84AEtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:09 INFO - Running setup.py (path:/tmp/pip-BMk32s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:09 INFO - Running setup.py (path:/tmp/pip-K5OVc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:09 INFO - Running setup.py (path:/tmp/pip-0e2Yxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:09 INFO - Running setup.py (path:/tmp/pip-Te5hlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:09 INFO - Running setup.py install for manifestparser 03:23:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozcrash 03:23:09 INFO - Running setup.py install for mozdebug 03:23:09 INFO - Running setup.py install for mozdevice 03:23:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozfile 03:23:10 INFO - Running setup.py install for mozhttpd 03:23:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozinfo 03:23:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozInstall 03:23:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozleak 03:23:10 INFO - Running setup.py install for mozlog 03:23:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for moznetwork 03:23:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozprocess 03:23:10 INFO - Running setup.py install for mozprofile 03:23:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozrunner 03:23:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozscreenshot 03:23:11 INFO - Running setup.py install for moztest 03:23:11 INFO - Running setup.py install for mozversion 03:23:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:11 INFO - Cleaning up... 03:23:11 INFO - Return code: 0 03:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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 03:23: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 03:23:11 INFO - Using env: {'DISPLAY': ':0', 03:23:11 INFO - 'HOME': '/home/cltbld', 03:23:11 INFO - 'LANG': 'en_US.UTF-8', 03:23:11 INFO - 'LANGUAGE': 'en_US:en', 03:23:11 INFO - 'LOGNAME': 'cltbld', 03:23:11 INFO - 'MAIL': '/var/mail/cltbld', 03:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:11 INFO - 'MOZ_NO_REMOTE': '1', 03:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:11 INFO - 'NO_EM_RESTART': '1', 03:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:11 INFO - 'PWD': '/builds/slave/test', 03:23:11 INFO - 'SHELL': '/bin/bash', 03:23:11 INFO - 'SHLVL': '1', 03:23:11 INFO - 'TERM': 'linux', 03:23:11 INFO - 'TMOUT': '86400', 03:23:11 INFO - 'USER': 'cltbld', 03:23:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:11 INFO - '_': '/tools/buildbot/bin/python'} 03:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:11 INFO - Running setup.py (path:/tmp/pip-756eBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:11 INFO - Running setup.py (path:/tmp/pip-Le2omE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:11 INFO - Running setup.py (path:/tmp/pip-ymWUg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:11 INFO - Running setup.py (path:/tmp/pip-Nd7eRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:11 INFO - Running setup.py (path:/tmp/pip-IrLY5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:11 INFO - Running setup.py (path:/tmp/pip-CfWH3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:11 INFO - Running setup.py (path:/tmp/pip-0R3WHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:12 INFO - Running setup.py (path:/tmp/pip-9EKPQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:12 INFO - Running setup.py (path:/tmp/pip-KdRpVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:12 INFO - Running setup.py (path:/tmp/pip-tGrWOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:12 INFO - Running setup.py (path:/tmp/pip-AvfxPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:12 INFO - Running setup.py (path:/tmp/pip-YcAF_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:12 INFO - Running setup.py (path:/tmp/pip-aMofzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:12 INFO - Running setup.py (path:/tmp/pip-kcGm0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23: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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:12 INFO - Running setup.py (path:/tmp/pip-Pg5WnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:12 INFO - Running setup.py (path:/tmp/pip-uEHraa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:12 INFO - Running setup.py (path:/tmp/pip-4yb6IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:13 INFO - Downloading blessings-1.6.tar.gz 03:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:13 INFO - Installing collected packages: blessings 03:23:13 INFO - Running setup.py install for blessings 03:23:14 INFO - Successfully installed blessings 03:23:14 INFO - Cleaning up... 03:23:14 INFO - Return code: 0 03:23:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:14 INFO - Reading from file tmpfile_stdout 03:23:14 INFO - Current package versions: 03:23:14 INFO - argparse == 1.2.1 03:23:14 INFO - blessings == 1.6 03:23:14 INFO - blobuploader == 1.2.4 03:23:14 INFO - docopt == 0.6.1 03:23:14 INFO - functools32 == 3.2.3-2 03:23:14 INFO - jsonschema == 2.5.1 03:23:14 INFO - manifestparser == 1.1 03:23:14 INFO - mozInstall == 1.13 03:23:14 INFO - mozcrash == 1.0 03:23:14 INFO - mozdebug == 0.1 03:23:14 INFO - mozdevice == 0.51 03:23:14 INFO - mozfile == 1.2 03:23:14 INFO - mozhttpd == 0.7 03:23:14 INFO - mozinfo == 0.10 03:23:14 INFO - mozleak == 0.1 03:23:14 INFO - mozlog == 3.5 03:23:14 INFO - moznetwork == 0.27 03:23:14 INFO - mozprocess == 0.25 03:23:14 INFO - mozprofile == 0.28 03:23:14 INFO - mozrunner == 6.13 03:23:14 INFO - mozscreenshot == 0.1 03:23:14 INFO - mozsystemmonitor == 0.3 03:23:14 INFO - moztest == 0.8 03:23:14 INFO - mozversion == 1.4 03:23:14 INFO - psutil == 3.1.1 03:23:14 INFO - requests == 1.2.3 03:23:14 INFO - wsgiref == 0.1.2 03:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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 03:23: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 03:23:14 INFO - Using env: {'DISPLAY': ':0', 03:23:14 INFO - 'HOME': '/home/cltbld', 03:23:14 INFO - 'LANG': 'en_US.UTF-8', 03:23:14 INFO - 'LANGUAGE': 'en_US:en', 03:23:14 INFO - 'LOGNAME': 'cltbld', 03:23:14 INFO - 'MAIL': '/var/mail/cltbld', 03:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:14 INFO - 'MOZ_NO_REMOTE': '1', 03:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:14 INFO - 'NO_EM_RESTART': '1', 03:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:14 INFO - 'PWD': '/builds/slave/test', 03:23:14 INFO - 'SHELL': '/bin/bash', 03:23:14 INFO - 'SHLVL': '1', 03:23:14 INFO - 'TERM': 'linux', 03:23:14 INFO - 'TMOUT': '86400', 03:23:14 INFO - 'USER': 'cltbld', 03:23:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:14 INFO - '_': '/tools/buildbot/bin/python'} 03:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23: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)) 03:23: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)) 03:23: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)) 03:23: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)) 03:23: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)) 03:23: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)) 03:23: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)) 03:23: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)) 03:23: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)) 03:23:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23: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 03:23: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 03:23: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 03:23: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 03:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:15 INFO - Installing collected packages: simplejson 03:23:15 INFO - Running setup.py install for simplejson 03:23:15 INFO - building 'simplejson._speedups' extension 03:23:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:23:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:23:16 INFO - Successfully installed simplejson 03:23:16 INFO - Cleaning up... 03:23:16 INFO - Return code: 0 03:23:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:16 INFO - Using env: {'DISPLAY': ':0', 03:23:16 INFO - 'HOME': '/home/cltbld', 03:23:16 INFO - 'LANG': 'en_US.UTF-8', 03:23:16 INFO - 'LANGUAGE': 'en_US:en', 03:23:16 INFO - 'LOGNAME': 'cltbld', 03:23:16 INFO - 'MAIL': '/var/mail/cltbld', 03:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:16 INFO - 'MOZ_NO_REMOTE': '1', 03:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:16 INFO - 'NO_EM_RESTART': '1', 03:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:16 INFO - 'PWD': '/builds/slave/test', 03:23:16 INFO - 'SHELL': '/bin/bash', 03:23:16 INFO - 'SHLVL': '1', 03:23:16 INFO - 'TERM': 'linux', 03:23:16 INFO - 'TMOUT': '86400', 03:23:16 INFO - 'USER': 'cltbld', 03:23:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:16 INFO - '_': '/tools/buildbot/bin/python'} 03:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:16 INFO - Cleaning up... 03:23:16 INFO - Return code: 0 03:23:16 INFO - Running post-action listener: _resource_record_post_action 03:23:16 INFO - Running post-action listener: _start_resource_monitoring 03:23:16 INFO - Starting resource monitoring. 03:23:16 INFO - [mozharness: 2017-09-16 10:23:16.997633Z] Finished create-virtualenv step (success) 03:23:16 INFO - [mozharness: 2017-09-16 10:23:16.998151Z] Running install step. 03:23:16 INFO - Running pre-action listener: _resource_record_pre_action 03:23:16 INFO - Running main action method: install 03:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:17 INFO - Reading from file tmpfile_stdout 03:23:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:17 INFO - Reading from file tmpfile_stdout 03:23:17 INFO - Output received: 03:23:17 INFO - Usage: mozinstall [options] installer 03:23:17 INFO - Options: 03:23:17 INFO - -h, --help show this help message and exit 03:23:17 INFO - -d DEST, --destination=DEST 03:23:17 INFO - Directory to install application into. [default: 03:23:17 INFO - "/builds/slave/test"] 03:23:17 INFO - --app=APP Application being installed. [default: firefox] 03:23:17 INFO - mkdir: /builds/slave/test/build/application 03:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:23:35 INFO - Reading from file tmpfile_stdout 03:23:35 INFO - Output received: 03:23:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:35 INFO - Running post-action listener: _resource_record_post_action 03:23:35 INFO - [mozharness: 2017-09-16 10:23:35.101568Z] Finished install step (success) 03:23:35 INFO - [mozharness: 2017-09-16 10:23:35.101821Z] Running setup-mitmproxy step. 03:23:35 INFO - Running pre-action listener: _resource_record_pre_action 03:23:35 INFO - Running main action method: setup_mitmproxy 03:23:35 INFO - Skipping: mitmproxy is not required 03:23:35 INFO - Running post-action listener: _resource_record_post_action 03:23:35 INFO - [mozharness: 2017-09-16 10:23:35.102940Z] Finished setup-mitmproxy step (success) 03:23:35 INFO - [mozharness: 2017-09-16 10:23:35.103158Z] Running run-tests step. 03:23:35 INFO - Running pre-action listener: _resource_record_pre_action 03:23:35 INFO - Running pre-action listener: _set_gcov_prefix 03:23:35 INFO - Running main action method: run_tests 03:23:35 WARNING - Try message not found. 03:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:35 INFO - Python 2.7.3 03:23:35 INFO - Return code: 0 03:23:35 INFO - grabbing minidump binary from tooltool 03:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:35 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 0x1610090>, '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 0x1610d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:23:35 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:23:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:23:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:35 INFO - Return code: 0 03:23:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:35 INFO - ENV: RUST_BACKTRACE is now full 03:23:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:35 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/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:23:35 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/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 03:23:35 INFO - Using env: {'DISPLAY': ':0', 03:23:35 INFO - 'HOME': '/home/cltbld', 03:23:35 INFO - 'LANG': 'en_US.UTF-8', 03:23:35 INFO - 'LANGUAGE': 'en_US:en', 03:23:35 INFO - 'LOGNAME': 'cltbld', 03:23:35 INFO - 'MAIL': '/var/mail/cltbld', 03:23:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:35 INFO - 'MOZ_ACCELERATED': '1', 03:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:35 INFO - 'MOZ_NO_REMOTE': '1', 03:23:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:35 INFO - 'MOZ_WEBRENDER': '1', 03:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:35 INFO - 'NO_EM_RESTART': '1', 03:23:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:35 INFO - 'PWD': '/builds/slave/test', 03:23:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:35 INFO - 'RUST_BACKTRACE': 'full', 03:23:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:35 INFO - 'SHELL': '/bin/bash', 03:23:35 INFO - 'SHLVL': '1', 03:23:35 INFO - 'TERM': 'linux', 03:23:35 INFO - 'TMOUT': '86400', 03:23:35 INFO - 'USER': 'cltbld', 03:23:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:35 INFO - '_': '/tools/buildbot/bin/python'} 03:23:35 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/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:23:35 INFO - mozversion application_buildid: 20170916093032 03:23:35 INFO - mozversion application_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:23:35 INFO - mozversion application_display_name: Nightly 03:23:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:35 INFO - mozversion application_name: Firefox 03:23:35 INFO - mozversion application_remotingname: firefox 03:23:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:23:35 INFO - mozversion application_vendor: Mozilla 03:23:35 INFO - mozversion application_version: 57.0a1 03:23:35 INFO - mozversion platform_buildid: 20170916093032 03:23:35 INFO - mozversion platform_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:23:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:23:35 INFO - mozversion platform_version: 57.0a1 03:23:35 INFO - using testdate: 1505557415 03:23:35 INFO - actual date: 1505557415 03:23:35 INFO - starting webserver on 'localhost:37070' 03:23:35 INFO - SUITE-START | Running 2 tests 03:23:35 INFO - TEST-START | dromaeo_css 03:23:35 INFO - Initialising browser for dromaeo_css test... 03:23:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37070/getInfo.html -profile /tmp/tmplbMnDH/profile 03:23:35 INFO - TEST-INFO | started process 29661 (/builds/slave/test/build/application/firefox/firefox http://localhost:37070/getInfo.html) 03:23:41 INFO - TEST-INFO | 29661: exit 0 03:23:41 INFO - Browser initialized. 03:23:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:41 INFO - Using env: {'DISPLAY': ':0', 03:23:41 INFO - 'HOME': '/home/cltbld', 03:23:41 INFO - 'JSGC_DISABLE_POISONING': '1', 03:23:41 INFO - 'LANG': 'en_US.UTF-8', 03:23:41 INFO - 'LANGUAGE': 'en_US:en', 03:23:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:23:41 INFO - 'LOGNAME': 'cltbld', 03:23:41 INFO - 'MAIL': '/var/mail/cltbld', 03:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:41 INFO - 'MOZ_ACCELERATED': '1', 03:23:41 INFO - 'MOZ_CRASHREPORTER': '1', 03:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:23:41 INFO - 'MOZ_NO_REMOTE': '1', 03:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:41 INFO - 'MOZ_WEBRENDER': '1', 03:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:41 INFO - 'NO_EM_RESTART': '1', 03:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:41 INFO - 'PWD': '/builds/slave/test', 03:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:41 INFO - 'RUST_BACKTRACE': 'full', 03:23:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:41 INFO - 'SHELL': '/bin/bash', 03:23:41 INFO - 'SHLVL': '1', 03:23:41 INFO - 'TERM': 'linux', 03:23:41 INFO - 'TMOUT': '86400', 03:23:41 INFO - 'USER': 'cltbld', 03:23:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:41 INFO - '_': '/tools/buildbot/bin/python'} 03:23:41 INFO - TEST-INFO | started process 29904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplbMnDH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:42 INFO - PID 29904 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:23:42 INFO - PID 29904 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:23:43 INFO - PID 29904 | 03:23:43 INFO - PID 29904 | (/builds/slave/test/build/application/firefox/firefox:29965): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:23:43 INFO - PID 29904 | 03:23:53 INFO - PID 29904 | RSS: Main: 195424256 03:23:53 INFO - PID 29904 | 03:26:51 INFO - PID 29904 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37070/tests/dromaeo/cssquery-ext.html) 03:26:52 INFO - PID 29904 | RSS: Main: 200851456 03:26:52 INFO - PID 29904 | 03:29:55 INFO - PID 29904 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-ext.html (next: http://localhost:37070/tests/dromaeo/cssquery-jquery.html) 03:29:55 INFO - PID 29904 | RSS: Main: 204451840 03:29:55 INFO - PID 29904 | 03:32:57 INFO - PID 29904 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37070/tests/dromaeo/cssquery-mootools.html) 03:32:58 INFO - PID 29904 | RSS: Main: 203821056 03:32:58 INFO - PID 29904 | 03:36:00 INFO - PID 29904 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37070/tests/dromaeo/cssquery-prototype.html) 03:36:01 INFO - PID 29904 | RSS: Main: 202203136 03:36:01 INFO - PID 29904 | 03:39:04 INFO - PID 29904 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37070/tests/dromaeo/cssquery-yui.html) 03:39:05 INFO - PID 29904 | RSS: Main: 204095488 03:39:05 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | Cycle 1(1): loaded http://localhost:37070/tests/dromaeo/cssquery-yui.html (next: http://localhost:37070/tests/dromaeo/cssquery-dojo.html) 03:42:07 INFO - PID 29904 | RSS: Main: 206286848 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | __start_tp_report 03:42:07 INFO - PID 29904 | _x_x_mozilla_page_load 03:42:07 INFO - PID 29904 | _x_x_mozilla_page_load_details 03:42:07 INFO - PID 29904 | |i|pagename|runs| 03:42:07 INFO - PID 29904 | |0;dojo.html;3079.030105516762;3124.3751249750057;3125.312431265122;3125.7499400048;3145.889893853714;5972.402759724026;6169.2288463942;6172.197614310139;6281.43467087962;6311.715972781224;6060.303065147509;6081.726322315495;6086.695665216733;6101.267847858252;6116;5607.299087614048;5619.157126431027;5634.619518218043;5642.125470552071;5683.687397193153;5728.570357223225;5781;5831.387704291052;5839.941600584004;5871.383504732005;5786.739596718136;5841;5855.912161317584;5871.794487192949;5880.3237627672725;5533.667979921218;5609.775608975636;5660.85847853807;5762.481376676098;5884.235049443545;5579.414161513023;5701.315842098933;5721.828345149652;5749.31008279005;5781.797637082724;6195.96902015487;6209.875802483925;6218.378162183791;6254.21822272216;6305.96847015762;6454.93545064548;6471.870562588769;6491.805245842632;6547.050677651761;6671.799846004627;6641.701123449457;6781.152355955505;6793.762218322335;6799;6808.761693340709;6235.033569796688;6252.937470625281;6265.0915617235705;6277.905831412487;6305.211848518935;6779.830504237433;6809.250982391933;6828.829279268058;6867.622280774505;6933.895991560131;6237.750489980441;6383.744650214032;6543.411093001652;6649.268580456146;6674.699638516278;6575.539712220098;6590.703418346186;6618.768343107968;6706.26231114577;6719.697613607399;6473.741050358027;6544.051112588648;6704.698288577026;6706.497012724065;6764.154480689914;6671.066050752898;6684.63234522106;6725.899111513331;6776.15298087739;6776.728930842711;4985.651004429727;5089.262057001714;5185.662931909414;5256.605754568346;5259.737013149327;4530.932036019462;4613.331066995267;4644.930326045112;4676.392069031072;4677.134730074947;5739.942600573941;5791.681457519792;5800.332961709373;5800.738966746507;5831.854203644858;6627.801165965029;6675.23234828001;6686.1642294713165;6707.5975441473665;6789.864202715918;5709.0865461525955;5747.913781293284;5780.624259423208;5783;5799.217105690678;5586.720663966786;5669.319681638147;5701.714914254354;5711.857203569861;5720.856978575485;6484.481241500669;6516.511261655395;6555.967220163964;6564.9671751640935;6565.277819439858;6661.873000917447;6666.366695163952;6712.53012289135;6736.259011508828;6755.898661519983;6449.838754031187;6476.740930362921;6548.116004339353;6548.705308261235;6589.341065893373;6326.367363263636;6434.099226108255;6473.8705225896165;6582.946728523413;6664.233613134552;6533.346665333429;6652.900206497004;6660.933390666225;6681.465482761465;6693.631850248283;6357.364263573791;6401.775937842153;6425.261094974137;6432.678366081771;6433.324500927335;6375.171227740364;6377.681115944277;6425.8714825704155;6447.677616119269;6459.031145328238;6316.873662526632;6347.492200624031;6393.7122829471855;6418.807435776934;6432.13166222554;6343.429091381798;6386.457151142205;6503.609783412821;6535.640539770358;6585.20977482686;6177.62934223948;6323.20959880015;6328.525360598066;6338.714757835816;6340.365963403808 03:42:07 INFO - PID 29904 | |1;ext.html;849.6389034660269;877.4077497689058;879.4547380624014;883.9657600607293;889.4707648948876;37981.24037519248;38232.61767382325;41287.38068928961;41348.37977430337;41460.58539414605;39051.804740976324;39506;39575.208495830135;39600.80199599005;39737.80131099348;7031.718731250757;7147.642617869085;7215;7222.783316500513;7708.614569271514;7785.41609379296;7875.212478752136;7896.80257993549;7903.960480197619;7936.6825326986855;7858.253465920729;7906.248906353916;7908.209179082103;7913.643886025143;7917.881231781528;7822.882656760153;7824.5696486693205;7851.21487851216;7862.056553213593;7863.174366691473;7711.961440192763;7720.845583088363;7796.4932279401655;7822.374210063182;7826.413019023539;38288;38505.80747096275;38718;38750.22499550021;38773.41839872404;3505.789652620851;3524.1718196223865;3544.946825797615;3547.0777597824494;3547.290541891632;31217.21956951072;31421;31438.842805786055;31457.528137077963;31530.684693153235;5141.30592370029;5222.060029194743;5267.288915996368;5292.391374991887;5363.544098751572;178956;179535;181518;181695.9999999987;181779.09110454362;41704.791476042425;42873.571264286955;47801.521984780404;48324;48447.75776121167;51330.23004654933;52246.47753522416;52276.21585676218;52309.47690523046;52423.47576524186;15793.447229347148;15946.521604351889;15983.840161598468;15988;16000.919995400182;12674.049446291565;12677.429515671633;12695.93652031734;12696.93651531755;12697.873021269854;14119.929400352932;14192.432302707775;14293.142411455347;14337;14374.856251437352;5710.400407957188;5737.913931291034;5746.741396637161;5852.268466441695;5871.178035075093;994.9204063674889;995.9004099590128;1011.8633984412011;1030.4641586375192;1033.9379637221791;22538.436539086328;22677;22916.770832291462;23004;23071.601694113928;1103.9282446640943;1118.0999295566985;1132.8130858408435;1133.8525991621036;1140.4981808004452;12190.329531875832;12196.878031219752;12202.450889709984;12234.265944043385;12264.938675306745;205268;206705;206763;206962;207085;53135;53472.465275346745;53509.73245133749;53804;53812;1427.093795439903;1462.495439073518;1468.3612628506635;1469.8750606198594;1479.7484427647325;22124.77875221227;22320.66519002184;22542.887285564124;22701.659475108216;22920.656190156828;36939.63060369362;37107.628923710414;37283.627163728015;37289.81355093207;37339.813300933325;192614;193021;193606;194315;194810;33374.163196128604;35289.47065794066;36220.27559448744;36257.81871090628;36337.818310908275;43293.35059974166;45320.54679453295;45328.77335613301;45368.54631453775;46505.76747116378;32724;33195.66804331926;33331.500027499125;33413.49879751757;33552.49671254982;31745;32653.836730817144;32698.673013269563;32801.34397312088;32803.34393312168;36566.451503228;37244.441333380564;37260.950647714635;37581;37657;31858.68141318557;32112.35775284528;32236.355272893943;32574.674253257162;32644;23840.973517251226;23953.281401557982;24201.273961781175;24377;24686.506269874862 03:42:07 INFO - PID 29904 | |2;jquery.html;547.7069767674295;564.2720890051834;571.2630706388759;579.9971000145;583.9824805255842;22303;22928.88535557322;23276.534469310605;23295.650565241493;23305.883470582645;23850;24345.87827060862;24595.508089838193;25608.871955640243;25856.22431327063;6580.670966451682;6594.8681026379445;6600.207975043001;6626.900596491057;6644.933550664504;6603.075569420285;6676.866462670744;6720.495962802785;6721.294264102272;6735.057092007123;6204.317525072239;6438.871222575545;6491.123698300717;6571.835704107388;6656.334366563329;6467.93532064678;6473.83815404614;6515.087887695727;6521.347865213441;6523.934760652404;5841;6020.8494787630225;6024.698765061773;6034.849128771816;6056.848578785522;28208.85895570509;28670.856645716845;28860.278493037633;28936.565951510744;29017.12948611524;2075.1491888325713;2084.8436367272516;2106.3259756877806;2107.104480595741;2110.5989861926187;18377.724334134866;18706.81293187064;18899.62200755991;18900.149493272696;18919.33782317626;2416.9154079607306;2489.8879550420274;2495.987520062406;2505.448801263737;2508.485760419128;116558;119404;119781.40109299398;133707;133909.99999999904;14330.163374786638;14614.34235459407;14658.780118298235;14967.756082488708;15094.54716358511;22869.313920582408;22979;23057;23089.307320780405;23164;9828.213742900694;9844.310898237054;9905.20758339331;9914.305998580174;10045.397276163454;9086.772830679285;9117.81764364709;9194.356395052282;9199.310051746146;9234.445933244027;8900.243479304203;8999.640014399482;9246.121618446237;9305.860412093823;9369.203617692436;2641.6037594361;2642.9867850661008;2646.113551960115;2780.471710375022;2844.6586409630977;937.6577549194495;967.2020583019038;971.5142428785607;973.090160699748;973.1971123822874;19491.610167796563;19815.30646427397;19846;20140.295089671792;20398;1001.1940387987594;1008.9848652270222;1015.4161357219629;1027.1885210683627;1036.4403222260046;10832.187585931088;11123.054540364159;11155.776884462266;11177.608783692533;11194;461387;476058;489047;496344;497100;110118;111206.44396778126;113379;113497;118676.40661796808;1108.1024370260116;1142.0635079235115;1145.1125377832248;1146.2893006335958;1146.5643055638805;17531.386401475887;17537;17594.560135996704;17712.91143544274;17853.196606153015;52042.47957520376;53184.73407632937;53898.461015389345;54724.726376367864;55158;68346.65826670834;68629.65685171742;68957.31042689508;70040.64979675069;70401.64799175972;14280;14504.85495145035;14524.273786310854;14528.564143075724;14535.982481226212;22372.664410034187;22864.199753008565;22931.656025159304;23129.653055204522;23517.059317627787;18227.817721822612;18406.81593184051;18419.355322563646;18436.446906592824;18477.72283415723;16534.09062501574;16691.582710432336;16694;16912.577185569968;16974.557162641315;18348.17433215535;18694;18750.34373796965;18786.906065469586;18910.716339255196;14394.640133996734;14407.207603581903;14456.349464273922;14496.565103046925;14543.418263269774;18180.36368727088;18183.54541136429;18303.176357063698;18311.084445777924;18457.446276611725 03:42:07 INFO - PID 29904 | |3;mootools.html;1325.456562809248;1367.9384427700752;1403.6631208509957;1406.022814144169;1412.682146517033;14665.266736663165;15410.22948852557;15410.61473463164;15418.845811541882;15450.381984720598;15081.773773393408;15121;15127.924360378183;15162.620934476643;15224.391024359013;2772.986135069322;2826.4347130573915;2842.7583655389317;2857.8428186449737;2876.0652787844033;2724.8637568121517;2732.7540521353076;2735.179446166152;2749.766269867064;2766.640336756219;2570.884310206045;2597.8441293522355;2723.700392956773;2865.6131422257936;2869.4404591104744;2690.4753573053263;2728;2736;2736.698963114056;2737.096758069832;2604.8306860054226;2644.9471010579873;2655.030913716499;2657.7608015278524;2658.9734102658917;14608.634784130376;14965.70068598622;14971.625709357244;14978.700425991528;15012.549623511311;7487.925120748777;7741.651625676858;7746.915431839547;7785.104712958026;7786.377089832799;5419.701916394597;5553.111502159675;5709.3434255060365;5728.484436400744;5765.913511297334;1830.1764206107173;1861.2368928739152;1898.2881419467699;1941.3981665683684;1945.7373254610588;25173.748262517325;26150;26379.208623741317;26396.340091497674;26430.471390572082;6706.899396509057;7103.89344159838;7139.92901064834;7159.713611455483;7183.92816071843;17010.064446455563;17043.744343834853;17120.914395427943;17158.22787974519;17205.311787528357;7185.784426467214;7448.888266676005;7595.772126836204;7677.193894641094;7680.34717049046;7137.643117844087;7231.674574644154;7290.234525374865;7301.780946571611;7303.269673032761;5101.7704203310195;5282.603804714585;5291.894162116736;5301.946980530222;5302.814401495929;1496.8278647955406;1550.550340401271;1566.5691934718043;1567.3103834312865;1580.5021418253214;854.2354592639552;862.607513581319;881.3389957531851;883.6023789294843;887.0685779931047;7049.4712896532965;7049.577025378494;7055.188653304833;7056.047433596502;7204.819879503054;697.8848489999194;713.9500234983606;716.4238674915207;723.1250187273353;735.3565630073685;4092.447519584818;4384.846530371422;5162.354705661793;5175.964807038607;5207.1668533034535;20250.291239806535;20765.95489742814;21185.576288474145;21577.352679419644;21652;19598.804011959983;20883.164673413197;21073.367798966057;21441.67837482439;21483.892580536998;10482.794478635054;10638.41488718128;10686.305390149615;10784.299020563638;11004.39475828837;8225.46534475281;8296;8329.6668133274;8339.638419879097;8407.369447291356;18292.542686432946;18451.630967380308;18974.0512974348;19046.14292356875;19129.139188736262;19260.8073919259;19304.32434864773;19369.225230990603;19761.308354207533;19886.50283742918;10827.458627068772;11052.557897684002;11097.778044438905;11108.833367499656;11111.277766945446;13073.215607063607;13095.934520327337;13196.736065278832;13210.669733256746;13215.735685286432;11240.83138752903;11443.48504317291;11509.654710358702;11549.249298795552;11714.355710436008;10880.619178328721;11054.613088541862;11236;11265.549378025114;11311.943440282746;9304.813903722023;9338.159565639126;9356;9373.062693730844;9402;6844.760433384808;6954.826129346807;6965.721371145098;6969.477289203432;7097.609631470319;6829.69266383004;6926.06498122747;6959.7216111357;6967.79096627102;7185.964070179824 03:42:07 INFO - PID 29904 | |4;prototype.html;505.1928086644026;505.8330750852217;519.361185741538;528.6903981078448;528.957683385329;6143.095640351494;6170.876582468348;6185;6224.875502489953;6303.905441418371;6124.387561243873;6134.417230363119;6159.168512250845;6175.845603859906;6189.381061893809;5115.872103197422;5129.358830146231;5135.563477104451;5161.406438259611;5163.81926632568;5092.898142037157;5127.846164615067;5141.485851414847;5151;5183.2743415921805;4721.952780472203;4861.052094841507;4863.902721945559;4899.6815207011605;5068.797248110071;4831.734254615994;4834.347363105989;4875.317455556225;4877.3903262092235;4879.829205977791;4355.477342718862;4363.5418281080665;4363.563643635611;4408.735475871458;4413.139437809628;5863.58954873159;5899.32157801854;5978.55160862937;5993.370696076936;6004.369541198199;5518.255035570227;5552.5280351170195;5561.77752889884;5581.720913954286;5595.328560572757;6355.745770169187;6388.361163883621;6400.2399340181355;6459.031145328238;6469.708863101172;4523.683342166049;4759;4781.235002399634;4823.083614113307;4830.855074347775;6465.644389558573;6471.320511346288;6592.406683398517;6706.920854535109;6710.228323742735;4893.926591101136;4924.261360795909;4932.717493451729;4961.305417241589;4963.851084467472;4917.9016419672125;4923.458419573915;4963.181075122637;4989.550940415307;4989.675671081368;5459.454054594588;5464.398916119224;5526.292116862708;5547.833564993057;5610.186522954149;6466.838329041718;6498.545101842826;6514.1531600891585;6514.73941042353;6525.282218955911;1718.1752758675905;1729.9394521191698;1737.3832289537286;1745.764321816564;1750.64111857069;1142.5144313666658;1190.4642910690052;1193.5822462138183;1195.450092957232;1218.6465924881861;5561.527270181999;5576.776928922879;5587.944120558824;5672.914906276409;5676.801311954062;6379.840503987438;6426.196725409324;6508.027666109073;6528.314526974599;6592.86814263712;5532.778688852401;5579.860503487364;5643.322801263875;5652.180433837153;5656.519195868315;3386.72906167506;3452.5166476693284;3464.133966508373;3497.9125521861647;3501.2472318451146;6243.594166379171;6332.303446620868;6373.426391624776;6394.9711681640265;6423.871522569522;6707.3963343298365;6734.427573656294;6739.93260067393;6798.728050878009;6820.35206655367;6267.905981410191;6330.39861213184;6444.2266927968;6492.577982431221;6495.902561461582;6100.276542022364;6340.207474065742;6519.380658837403;6572.502449069323;6578.243501997332;6399.488040956805;6524.771632992823;6548.345165483413;6552.770653027121;6559.770408035696;6136.693165341626;6182.28903676083;6190.164327815687;6331.620102793847;6331.715072821642;4874.926876096933;4908.165611845923;4921.803127874988;4951.306817045688;4960.379952505937;6271.78048768291;6482.643454610042;6534.150560427114;6586.506012049212;6605.003972596702;6152.477039451518;6254.6247225166635;6273.341299163522;6350.729854029305;6355.616643758591;6240.28236752761;6259.530535209787;6279.434850863444;6366.331535188739;6370.299267080525;6224.62652240867;6312.936870631235;6346.238451385863;6388.68056597159;6400.679966001589;6375.968120159369;6395.264544577433;6420.454261387835;6428.164338635947;6428.967855160694;6121.908171377522;6165.106059621419;6208.596441231305;6215.254169499689;6249.500039996698 03:42:07 INFO - PID 29904 | |5;yui.html;914.2229105260529;920.1304766995188;931.4550987672211;938.0759951447827;947.209080417851;18475.35336263231;18921.337753178606;18930.14814333355;18953.526161845944;19064.523386915316;17395.82604173958;17701.0264435456;17758.82241177588;17960.191791369387;18002.549936251602;896.6547879066558;921.7004473546124;928.0904713380891;929.7071422501924;932.3194068330089;941.7598512379334;949.2832911152105;955.1308309438413;955.4171955107379;955.9091886270793;955.4840386191448;981.7741919358551;987.4963768478092;989.0554520432969;993.8509223616443;973.4986481961795;977.4770497783652;983.0611765763679;984.527426835116;986.7187851462298;695.7808290388512;716.9641517924083;719.7085180501905;720.344486517272;723.9312265334785;18637.16132774015;18639.161237744334;18702.62594748111;18770.249190032384;18774;18710.532236694056;19022;19793.30723424673;20312.882791446464;20469.8976505118;16892.577685557837;17095;17175;17265;17603.911980440145;3738.962610373916;3815.4086116651965;3825.2731980923813;3829.4447305140875;3832.0419895026243;100642.49678751633;102884.48557757238;139055;143563.28218358947;148874.25562872118;17733.911330443523;17844.55388615295;18050.458486245432;18087.819121808614;18210.45368638943;31320.843395782875;31657.05028849138;32043.839780800947;32369.190770230463;32391.35217295641;9262.861057084148;9429.292803039662;9459.290553208399;9469.573869175903;9495.525223738923;4453.0648563801315;4492.573205545468;4512;4528.773561321987;4541.455025396974;4907.288443175791;4969.503049695074;4993.300937868701;5056.570191533688;5083.364579427572;1058.8570542976754;1060.6181774561153;1084.8752393474851;1085.115630760943;1091.1161958813386;630.7729217481703;632.358156471173;645.8159424563977;650.187265917603;654.2214764430313;11763.353015584225;12017;12856.807147892789;12952.546660866825;13044;607.9483243924316;614.4500671898626;618.0204376063899;622.551762730833;623.3392603839853;5465.535429488458;5622.100463925753;5703.486686198262;5772.7113644317615;5773.826785196451;115522;123286;124910;125096;127296;106812.46593766981;106834;108974.45512772385;109607.45196273968;111402.44298778454;92953.53523232341;93626;96023;96403.51798240964;96840.54739178918;10133.695989120339;10219.948900255451;10477.476126193507;10530.736731581772;10655.946720266658;43180.352294716235;44611.33083003823;44755;45401.545984539734;45448.091038179715;57119;57595.71202143963;57699;57966;58562.12156817566;15963.760543591623;16012.919935400249;16053.759193612339;16111;16350.836491635408;16118.2746776393;16143.67712645764;16446.342146314015;16457;16801.243944022794;15631.84368156304;15909.840901590836;16051.598710032342;16060.196990150213;16178.838211617733;15972.041677499386;16003.599910001878;16050.357985680908;16101.838981610033;16340.591485212964;15533.223338833239;15549.84450155484;15686.764698529303;15716;15728.685426291639;10037.146842518176;10053.246006549392;10210.489475526343;10346.430946297725;10348.896511035095;11802.291862488279;11913.285202887855;12049.277043377426;12134.575289864812;12175.33035683046 03:42:07 INFO - PID 29904 | __end_tp_report 03:42:07 INFO - PID 29904 | __start_cc_report 03:42:07 INFO - PID 29904 | _x_x_mozilla_cycle_collect,322 03:42:07 INFO - PID 29904 | __end_cc_report 03:42:07 INFO - PID 29904 | __startTimestamp1505558527627__endTimestamp 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | ------- Summary: start ------- 03:42:07 INFO - PID 29904 | Number of tests: 6 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | [#0] dojo.html Cycles:165 Average:6116.17 Median:6340.37 stddev:730.99 (11.5%) stddev-sans-first:693.31 03:42:07 INFO - PID 29904 | Values: 3079.0 3124.4 3125.3 3125.7 3145.9 5972.4 6169.2 6172.2 6281.4 6311.7 6060.3 6081.7 6086.7 6101.3 6116.0 5607.3 5619.2 5634.6 5642.1 5683.7 5728.6 5781.0 5831.4 5839.9 5871.4 5786.7 5841.0 5855.9 5871.8 5880.3 5533.7 5609.8 5660.9 5762.5 5884.2 5579.4 5701.3 5721.8 5749.3 5781.8 6196.0 6209.9 6218.4 6254.2 6306.0 6454.9 6471.9 6491.8 6547.1 6671.8 6641.7 6781.2 6793.8 6799.0 6808.8 6235.0 6252.9 6265.1 6277.9 6305.2 6779.8 6809.3 6828.8 6867.6 6933.9 6237.8 6383.7 6543.4 6649.3 6674.7 6575.5 6590.7 6618.8 6706.3 6719.7 6473.7 6544.1 6704.7 6706.5 6764.2 6671.1 6684.6 6725.9 6776.2 6776.7 4985.7 5089.3 5185.7 5256.6 5259.7 4530.9 4613.3 4644.9 4676.4 4677.1 5739.9 5791.7 5800.3 5800.7 5831.9 6627.8 6675.2 6686.2 6707.6 6789.9 5709.1 5747.9 5780.6 5783.0 5799.2 5586.7 5669.3 5701.7 5711.9 5720.9 6484.5 6516.5 6556.0 6565.0 6565.3 6661.9 6666.4 6712.5 6736.3 6755.9 6449.8 6476.7 6548.1 6548.7 6589.3 6326.4 6434.1 6473.9 6582.9 6664.2 6533.3 6652.9 6660.9 6681.5 6693.6 6357.4 6401.8 6425.3 6432.7 6433.3 6375.2 6377.7 6425.9 6447.7 6459.0 6316.9 6347.5 6393.7 6418.8 6432.1 6343.4 6386.5 6503.6 6535.6 6585.2 6177.6 6323.2 6328.5 6338.7 6340.4 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | [#1] ext.html Cycles:180 Average:36599.59 Median:36239.05 stddev:50135.32 (138.3%) stddev-sans-first:50204.10 03:42:07 INFO - PID 29904 | Values: 849.6 877.4 879.5 884.0 889.5 37981.2 38232.6 41287.4 41348.4 41460.6 39051.8 39506.0 39575.2 39600.8 39737.8 7031.7 7147.6 7215.0 7222.8 7708.6 7785.4 7875.2 7896.8 7904.0 7936.7 7858.3 7906.2 7908.2 7913.6 7917.9 7822.9 7824.6 7851.2 7862.1 7863.2 7712.0 7720.8 7796.5 7822.4 7826.4 38288.0 38505.8 38718.0 38750.2 38773.4 3505.8 3524.2 3544.9 3547.1 3547.3 31217.2 31421.0 31438.8 31457.5 31530.7 5141.3 5222.1 5267.3 5292.4 5363.5 178956.0 179535.0 181518.0 181696.0 181779.1 41704.8 42873.6 47801.5 48324.0 48447.8 51330.2 52246.5 52276.2 52309.5 52423.5 15793.4 15946.5 15983.8 15988.0 16000.9 12674.0 12677.4 12695.9 12696.9 12697.9 14119.9 14192.4 14293.1 14337.0 14374.9 5710.4 5737.9 5746.7 5852.3 5871.2 994.9 995.9 1011.9 1030.5 1033.9 22538.4 22677.0 22916.8 23004.0 23071.6 1103.9 1118.1 1132.8 1133.9 1140.5 12190.3 12196.9 12202.5 12234.3 12264.9 205268.0 206705.0 206763.0 206962.0 207085.0 53135.0 53472.5 53509.7 53804.0 53812.0 1427.1 1462.5 1468.4 1469.9 1479.7 22124.8 22320.7 22542.9 22701.7 22920.7 36939.6 37107.6 37283.6 37289.8 37339.8 192614.0 193021.0 193606.0 194315.0 194810.0 33374.2 35289.5 36220.3 36257.8 36337.8 43293.4 45320.5 45328.8 45368.5 46505.8 32724.0 33195.7 33331.5 33413.5 33552.5 31745.0 32653.8 32698.7 32801.3 32803.3 36566.5 37244.4 37261.0 37581.0 37657.0 31858.7 32112.4 32236.4 32574.7 32644.0 23841.0 23953.3 24201.3 24377.0 24686.5 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | [#2] jquery.html Cycles:180 Average:33957.10 Median:23146.83 stddev:81145.33 (350.6%) stddev-sans-first:81334.19 03:42:07 INFO - PID 29904 | Values: 547.7 564.3 571.3 580.0 584.0 22303.0 22928.9 23276.5 23295.7 23305.9 23850.0 24345.9 24595.5 25608.9 25856.2 6580.7 6594.9 6600.2 6626.9 6644.9 6603.1 6676.9 6720.5 6721.3 6735.1 6204.3 6438.9 6491.1 6571.8 6656.3 6467.9 6473.8 6515.1 6521.3 6523.9 5841.0 6020.8 6024.7 6034.8 6056.8 28208.9 28670.9 28860.3 28936.6 29017.1 2075.1 2084.8 2106.3 2107.1 2110.6 18377.7 18706.8 18899.6 18900.1 18919.3 2416.9 2489.9 2496.0 2505.4 2508.5 116558.0 119404.0 119781.4 133707.0 133910.0 14330.2 14614.3 14658.8 14967.8 15094.5 22869.3 22979.0 23057.0 23089.3 23164.0 9828.2 9844.3 9905.2 9914.3 10045.4 9086.8 9117.8 9194.4 9199.3 9234.4 8900.2 8999.6 9246.1 9305.9 9369.2 2641.6 2643.0 2646.1 2780.5 2844.7 937.7 967.2 971.5 973.1 973.2 19491.6 19815.3 19846.0 20140.3 20398.0 1001.2 1009.0 1015.4 1027.2 1036.4 10832.2 11123.1 11155.8 11177.6 11194.0 461387.0 476058.0 489047.0 496344.0 497100.0 110118.0 111206.4 113379.0 113497.0 118676.4 1108.1 1142.1 1145.1 1146.3 1146.6 17531.4 17537.0 17594.6 17712.9 17853.2 52042.5 53184.7 53898.5 54724.7 55158.0 68346.7 68629.7 68957.3 70040.6 70401.6 14280.0 14504.9 14524.3 14528.6 14536.0 22372.7 22864.2 22931.7 23129.7 23517.1 18227.8 18406.8 18419.4 18436.4 18477.7 16534.1 16691.6 16694.0 16912.6 16974.6 18348.2 18694.0 18750.3 18786.9 18910.7 14394.6 14407.2 14456.3 14496.6 14543.4 18180.4 18183.5 18303.2 18311.1 18457.4 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | [#3] mootools.html Cycles:180 Average:9177.75 Median:2658.37 stddev:6603.29 (248.4%) stddev-sans-first:6595.46 03:42:07 INFO - PID 29904 | Values: 1325.5 1367.9 1403.7 1406.0 1412.7 14665.3 15410.2 15410.6 15418.8 15450.4 15081.8 15121.0 15127.9 15162.6 15224.4 2773.0 2826.4 2842.8 2857.8 2876.1 2724.9 2732.8 2735.2 2749.8 2766.6 2570.9 2597.8 2723.7 2865.6 2869.4 2690.5 2728.0 2736.0 2736.7 2737.1 2604.8 2644.9 2655.0 2657.8 2659.0 14608.6 14965.7 14971.6 14978.7 15012.5 7487.9 7741.7 7746.9 7785.1 7786.4 5419.7 5553.1 5709.3 5728.5 5765.9 1830.2 1861.2 1898.3 1941.4 1945.7 25173.7 26150.0 26379.2 26396.3 26430.5 6706.9 7103.9 7139.9 7159.7 7183.9 17010.1 17043.7 17120.9 17158.2 17205.3 7185.8 7448.9 7595.8 7677.2 7680.3 7137.6 7231.7 7290.2 7301.8 7303.3 5101.8 5282.6 5291.9 5301.9 5302.8 1496.8 1550.6 1566.6 1567.3 1580.5 854.2 862.6 881.3 883.6 887.1 7049.5 7049.6 7055.2 7056.0 7204.8 697.9 714.0 716.4 723.1 735.4 4092.4 4384.8 5162.4 5176.0 5207.2 20250.3 20766.0 21185.6 21577.4 21652.0 19598.8 20883.2 21073.4 21441.7 21483.9 10482.8 10638.4 10686.3 10784.3 11004.4 8225.5 8296.0 8329.7 8339.6 8407.4 18292.5 18451.6 18974.1 19046.1 19129.1 19260.8 19304.3 19369.2 19761.3 19886.5 10827.5 11052.6 11097.8 11108.8 11111.3 13073.2 13095.9 13196.7 13210.7 13215.7 11240.8 11443.5 11509.7 11549.2 11714.4 10880.6 11054.6 11236.0 11265.5 11311.9 9304.8 9338.2 9356.0 9373.1 9402.0 6844.8 6954.8 6965.7 6969.5 7097.6 6829.7 6926.1 6959.7 6967.8 7186.0 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | [#4] prototype.html Cycles:180 Average:5394.14 Median:6111.09 stddev:1497.52 (24.5%) stddev-sans-first:1456.07 03:42:07 INFO - PID 29904 | Values: 505.2 505.8 519.4 528.7 529.0 6143.1 6170.9 6185.0 6224.9 6303.9 6124.4 6134.4 6159.2 6175.8 6189.4 5115.9 5129.4 5135.6 5161.4 5163.8 5092.9 5127.8 5141.5 5151.0 5183.3 4722.0 4861.1 4863.9 4899.7 5068.8 4831.7 4834.3 4875.3 4877.4 4879.8 4355.5 4363.5 4363.6 4408.7 4413.1 5863.6 5899.3 5978.6 5993.4 6004.4 5518.3 5552.5 5561.8 5581.7 5595.3 6355.7 6388.4 6400.2 6459.0 6469.7 4523.7 4759.0 4781.2 4823.1 4830.9 6465.6 6471.3 6592.4 6706.9 6710.2 4893.9 4924.3 4932.7 4961.3 4963.9 4917.9 4923.5 4963.2 4989.6 4989.7 5459.5 5464.4 5526.3 5547.8 5610.2 6466.8 6498.5 6514.2 6514.7 6525.3 1718.2 1729.9 1737.4 1745.8 1750.6 1142.5 1190.5 1193.6 1195.5 1218.6 5561.5 5576.8 5587.9 5672.9 5676.8 6379.8 6426.2 6508.0 6528.3 6592.9 5532.8 5579.9 5643.3 5652.2 5656.5 3386.7 3452.5 3464.1 3497.9 3501.2 6243.6 6332.3 6373.4 6395.0 6423.9 6707.4 6734.4 6739.9 6798.7 6820.4 6267.9 6330.4 6444.2 6492.6 6495.9 6100.3 6340.2 6519.4 6572.5 6578.2 6399.5 6524.8 6548.3 6552.8 6559.8 6136.7 6182.3 6190.2 6331.6 6331.7 4874.9 4908.2 4921.8 4951.3 4960.4 6271.8 6482.6 6534.2 6586.5 6605.0 6152.5 6254.6 6273.3 6350.7 6355.6 6240.3 6259.5 6279.4 6366.3 6370.3 6224.6 6312.9 6346.2 6388.7 6400.7 6376.0 6395.3 6420.5 6428.2 6429.0 6121.9 6165.1 6208.6 6215.3 6249.5 03:42:07 INFO - PID 29904 | 03:42:07 INFO - PID 29904 | [#5] yui.html Cycles:180 Average:23897.21 Median:19043.26 stddev:34440.83 (180.9%) stddev-sans-first:34494.21 03:42:07 INFO - PID 29904 | Values: 914.2 920.1 931.5 938.1 947.2 18475.4 18921.3 18930.1 18953.5 19064.5 17395.8 17701.0 17758.8 17960.2 18002.5 896.7 921.7 928.1 929.7 932.3 941.8 949.3 955.1 955.4 955.9 955.5 981.8 987.5 989.1 993.9 973.5 977.5 983.1 984.5 986.7 695.8 717.0 719.7 720.3 723.9 18637.2 18639.2 18702.6 18770.2 18774.0 18710.5 19022.0 19793.3 20312.9 20469.9 16892.6 17095.0 17175.0 17265.0 17603.9 3739.0 3815.4 3825.3 3829.4 3832.0 100642.5 102884.5 139055.0 143563.3 148874.3 17733.9 17844.6 18050.5 18087.8 18210.5 31320.8 31657.1 32043.8 32369.2 32391.4 9262.9 9429.3 9459.3 9469.6 9495.5 4453.1 4492.6 4512.0 4528.8 4541.5 4907.3 4969.5 4993.3 5056.6 5083.4 1058.9 1060.6 1084.9 1085.1 1091.1 630.8 632.4 645.8 650.2 654.2 11763.4 12017.0 12856.8 12952.5 13044.0 607.9 614.5 618.0 622.6 623.3 5465.5 5622.1 5703.5 5772.7 5773.8 115522.0 123286.0 124910.0 125096.0 127296.0 106812.5 106834.0 108974.5 109607.5 111402.4 92953.5 93626.0 96023.0 96403.5 96840.5 10133.7 10219.9 10477.5 10530.7 10655.9 43180.4 44611.3 44755.0 45401.5 45448.1 57119.0 57595.7 57699.0 57966.0 58562.1 15963.8 16012.9 16053.8 16111.0 16350.8 16118.3 16143.7 16446.3 16457.0 16801.2 15631.8 15909.8 16051.6 16060.2 16178.8 15972.0 16003.6 16050.4 16101.8 16340.6 15533.2 15549.8 15686.8 15716.0 15728.7 10037.1 10053.2 10210.5 10346.4 10348.9 11802.3 11913.3 12049.3 12134.6 12175.3 03:42:07 INFO - PID 29904 | -------- Summary: end -------- 03:42:07 INFO - PID 29904 | 03:42:08 INFO - TEST-INFO | 29904: exit 0 03:42:08 INFO - TEST-OK | dromaeo_css | took 1113036ms 03:42:08 INFO - TEST-START | kraken 03:42:08 INFO - Initialising browser for kraken test... 03:42:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37070/getInfo.html -profile /tmp/tmpTo7MMJ/profile 03:42:08 INFO - TEST-INFO | started process 30287 (/builds/slave/test/build/application/firefox/firefox http://localhost:37070/getInfo.html) 03:42:14 INFO - TEST-INFO | 30287: exit 0 03:42:14 INFO - Browser initialized. 03:42:14 INFO - Running cycle 1/1 for kraken test... 03:42:14 INFO - Using env: {'DISPLAY': ':0', 03:42:14 INFO - 'HOME': '/home/cltbld', 03:42:14 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:14 INFO - 'LANG': 'en_US.UTF-8', 03:42:14 INFO - 'LANGUAGE': 'en_US:en', 03:42:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:14 INFO - 'LOGNAME': 'cltbld', 03:42:14 INFO - 'MAIL': '/var/mail/cltbld', 03:42:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:14 INFO - 'MOZ_ACCELERATED': '1', 03:42:14 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:14 INFO - 'MOZ_NO_REMOTE': '1', 03:42:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:14 INFO - 'MOZ_WEBRENDER': '1', 03:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:14 INFO - 'NO_EM_RESTART': '1', 03:42:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:14 INFO - 'PWD': '/builds/slave/test', 03:42:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:14 INFO - 'RUST_BACKTRACE': 'full', 03:42:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:14 INFO - 'SHELL': '/bin/bash', 03:42:14 INFO - 'SHLVL': '1', 03:42:14 INFO - 'TERM': 'linux', 03:42:14 INFO - 'TMOUT': '86400', 03:42:14 INFO - 'USER': 'cltbld', 03:42:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759', 03:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:14 INFO - '_': '/tools/buildbot/bin/python'} 03:42:14 INFO - TEST-INFO | started process 30532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTo7MMJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:15 INFO - PID 30532 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:42:15 INFO - PID 30532 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:42:15 INFO - PID 30532 | 03:42:15 INFO - PID 30532 | (/builds/slave/test/build/application/firefox/firefox:30591): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:15 INFO - PID 30532 | 03:42:26 INFO - PID 30532 | RSS: Main: 193032192 03:42:26 INFO - PID 30532 | 03:42:28 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:29 INFO - PID 30532 | RSS: Main: 199520256 03:42:29 INFO - PID 30532 | 03:42:32 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-dft) 03:42:33 INFO - PID 30532 | RSS: Main: 198578176 03:42:33 INFO - PID 30532 | 03:42:36 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-fft) 03:42:36 INFO - PID 30532 | RSS: Main: 196960256 03:42:36 INFO - PID 30532 | 03:42:39 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37070/tests/kraken/driver.html?testName=audio-oscillator) 03:42:39 INFO - PID 30532 | RSS: Main: 197255168 03:42:39 INFO - PID 30532 | 03:42:41 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:42 INFO - PID 30532 | RSS: Main: 197353472 03:42:42 INFO - PID 30532 | 03:42:45 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37070/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:46 INFO - PID 30532 | RSS: Main: 199839744 03:42:46 INFO - PID 30532 | 03:42:50 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37070/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:50 INFO - PID 30532 | RSS: Main: 199458816 03:42:50 INFO - PID 30532 | 03:42:53 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37070/tests/kraken/driver.html?testName=json-parse-financial) 03:42:54 INFO - PID 30532 | RSS: Main: 199794688 03:42:54 INFO - PID 30532 | 03:42:55 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:56 INFO - PID 30532 | RSS: Main: 200605696 03:42:56 INFO - PID 30532 | 03:42:58 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:58 INFO - PID 30532 | RSS: Main: 197345280 03:42:58 INFO - PID 30532 | 03:43:01 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:01 INFO - PID 30532 | RSS: Main: 196046848 03:43:01 INFO - PID 30532 | 03:43:04 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:05 INFO - PID 30532 | RSS: Main: 195723264 03:43:05 INFO - PID 30532 | 03:43:08 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:08 INFO - PID 30532 | RSS: Main: 196960256 03:43:08 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | Cycle 1(1): loaded http://localhost:37070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37070/tests/kraken/driver.html?testName=ai-astar) 03:43:10 INFO - PID 30532 | RSS: Main: 200065024 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | __start_tp_report 03:43:10 INFO - PID 30532 | _x_x_mozilla_page_load 03:43:10 INFO - PID 30532 | _x_x_mozilla_page_load_details 03:43:10 INFO - PID 30532 | |i|pagename|runs| 03:43:10 INFO - PID 30532 | |0;ai-astar;110;115;109;111;111;114;108;114;112;114 03:43:10 INFO - PID 30532 | |1;audio-beat-detection;128;128;127;117;125;118;120;125;117;122 03:43:10 INFO - PID 30532 | |2;audio-dft;164;162;162;169;167;166;167;166;169;165 03:43:10 INFO - PID 30532 | |3;audio-fft;75;73;79;82;77;78;74;74;75;84 03:43:10 INFO - PID 30532 | |4;audio-oscillator;88;87;87;79;84;81;84;79;84;84 03:43:10 INFO - PID 30532 | |5;imaging-gaussian-blur;115;121;128;114;115;119;114;118;116;112 03:43:10 INFO - PID 30532 | |6;imaging-darkroom;148;150;150;150;153;149;149;149;155;148 03:43:10 INFO - PID 30532 | |7;imaging-desaturate;95;96;96;98;98;98;100;97;97;96 03:43:10 INFO - PID 30532 | |8;json-parse-financial;54;53;62;55;54;55;55;53;65;54 03:43:10 INFO - PID 30532 | |9;json-stringify-tinderbox;43;46;47;39;48;42;39;39;38;39 03:43:10 INFO - PID 30532 | |10;stanford-crypto-aes;84;81;74;75;79;83;79;90;77;75 03:43:10 INFO - PID 30532 | |11;stanford-crypto-ccm;117;125;116;110;113;112;117;113;119;116 03:43:10 INFO - PID 30532 | |12;stanford-crypto-pbkdf2;180;179;172;170;171;172;188;170;182;172 03:43:10 INFO - PID 30532 | |13;stanford-crypto-sha256-iterative;71;65;64;66;70;66;71;65;69;67 03:43:10 INFO - PID 30532 | __end_tp_report 03:43:10 INFO - PID 30532 | __start_cc_report 03:43:10 INFO - PID 30532 | _x_x_mozilla_cycle_collect,733 03:43:10 INFO - PID 30532 | __end_cc_report 03:43:10 INFO - PID 30532 | __startTimestamp1505558590702__endTimestamp 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | ------- Summary: start ------- 03:43:10 INFO - PID 30532 | Number of tests: 14 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.39 (2.1%) stddev-sans-first:2.45 03:43:10 INFO - PID 30532 | Values: 110.0 115.0 109.0 111.0 111.0 114.0 108.0 114.0 112.0 114.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:125.00 stddev:4.47 (3.6%) stddev-sans-first:4.31 03:43:10 INFO - PID 30532 | Values: 128.0 128.0 127.0 117.0 125.0 118.0 120.0 125.0 117.0 122.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.50 stddev:2.50 (1.5%) stddev-sans-first:2.57 03:43:10 INFO - PID 30532 | Values: 164.0 162.0 162.0 169.0 167.0 166.0 167.0 166.0 169.0 165.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#3] audio-fft Cycles:10 Average:77.10 Median:77.50 stddev:3.67 (4.7%) stddev-sans-first:3.81 03:43:10 INFO - PID 30532 | Values: 75.0 73.0 79.0 82.0 77.0 78.0 74.0 74.0 75.0 84.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:84.00 stddev:3.20 (3.8%) stddev-sans-first:2.99 03:43:10 INFO - PID 30532 | Values: 88.0 87.0 87.0 79.0 84.0 81.0 84.0 79.0 84.0 84.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:4.64 (4.0%) stddev-sans-first:4.85 03:43:10 INFO - PID 30532 | Values: 115.0 121.0 128.0 114.0 115.0 119.0 114.0 118.0 116.0 112.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:2.23 (1.5%) stddev-sans-first:2.24 03:43:10 INFO - PID 30532 | Values: 148.0 150.0 150.0 150.0 153.0 149.0 149.0 149.0 155.0 148.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:1.45 (1.5%) stddev-sans-first:1.32 03:43:10 INFO - PID 30532 | Values: 95.0 96.0 96.0 98.0 98.0 98.0 100.0 97.0 97.0 96.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.00 stddev:4.08 (7.4%) stddev-sans-first:4.27 03:43:10 INFO - PID 30532 | Values: 54.0 53.0 62.0 55.0 54.0 55.0 55.0 53.0 65.0 54.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#9] json-stringify-tinderbox Cycles:10 Average:42.00 Median:42.50 stddev:3.80 (8.9%) stddev-sans-first:4.01 03:43:10 INFO - PID 30532 | Values: 43.0 46.0 47.0 39.0 48.0 42.0 39.0 39.0 38.0 39.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:4.97 (6.2%) stddev-sans-first:5.02 03:43:10 INFO - PID 30532 | Values: 84.0 81.0 74.0 75.0 79.0 83.0 79.0 90.0 77.0 75.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:116.50 stddev:4.24 (3.6%) stddev-sans-first:4.47 03:43:10 INFO - PID 30532 | Values: 117.0 125.0 116.0 110.0 113.0 112.0 117.0 113.0 119.0 116.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:175.50 stddev:6.22 (3.5%) stddev-sans-first:6.39 03:43:10 INFO - PID 30532 | Values: 180.0 179.0 172.0 170.0 171.0 172.0 188.0 170.0 182.0 172.0 03:43:10 INFO - PID 30532 | 03:43:10 INFO - PID 30532 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:2.63 (3.9%) stddev-sans-first:2.45 03:43:10 INFO - PID 30532 | Values: 71.0 65.0 64.0 66.0 70.0 66.0 71.0 65.0 69.0 67.0 03:43:10 INFO - PID 30532 | -------- Summary: end -------- 03:43:10 INFO - PID 30532 | 03:43:11 INFO - PID 30532 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:43:11 INFO - TEST-INFO | 30532: exit 0 03:43:11 INFO - TEST-OK | kraken | took 63078ms 03:43:11 INFO - SUITE-END | took 1176s 03:43:11 INFO - Completed test suite (00:19:36) 03:43:11 INFO - javascript benchmark 03:43:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8394.559081960448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.030105516762, 3124.3751249750057, 3125.312431265122, 3125.7499400048, 3145.889893853714, 5972.402759724026, 6169.2288463942, 6172.197614310139, 6281.43467087962, 6311.715972781224, 6060.303065147509, 6081.726322315495, 6086.695665216733, 6101.267847858252, 6116.0, 5607.299087614048, 5619.157126431027, 5634.619518218043, 5642.125470552071, 5683.687397193153, 5728.570357223225, 5781.0, 5831.387704291052, 5839.941600584004, 5871.383504732005, 5786.739596718136, 5841.0, 5855.912161317584, 5871.794487192949, 5880.3237627672725, 5533.667979921218, 5609.775608975636, 5660.85847853807, 5762.481376676098, 5884.235049443545, 5579.414161513023, 5701.315842098933, 5721.828345149652, 5749.31008279005, 5781.797637082724, 6195.96902015487, 6209.875802483925, 6218.378162183791, 6254.21822272216, 6305.96847015762, 6454.93545064548, 6471.870562588769, 6491.805245842632, 6547.050677651761, 6671.799846004627, 6641.701123449457, 6781.152355955505, 6793.762218322335, 6799.0, 6808.761693340709, 6235.033569796688, 6252.937470625281, 6265.0915617235705, 6277.905831412487, 6305.211848518935, 6779.830504237433, 6809.250982391933, 6828.829279268058, 6867.622280774505, 6933.895991560131, 6237.750489980441, 6383.744650214032, 6543.411093001652, 6649.268580456146, 6674.699638516278, 6575.539712220098, 6590.703418346186, 6618.768343107968, 6706.26231114577, 6719.697613607399, 6473.741050358027, 6544.051112588648, 6704.698288577026, 6706.497012724065, 6764.154480689914, 6671.066050752898, 6684.63234522106, 6725.899111513331, 6776.15298087739, 6776.728930842711, 4985.651004429727, 5089.262057001714, 5185.662931909414, 5256.605754568346, 5259.737013149327, 4530.932036019462, 4613.331066995267, 4644.930326045112, 4676.392069031072, 4677.134730074947, 5739.942600573941, 5791.681457519792, 5800.332961709373, 5800.738966746507, 5831.854203644858, 6627.801165965029, 6675.23234828001, 6686.1642294713165, 6707.5975441473665, 6789.864202715918, 5709.0865461525955, 5747.913781293284, 5780.624259423208, 5783.0, 5799.217105690678, 5586.720663966786, 5669.319681638147, 5701.714914254354, 5711.857203569861, 5720.856978575485, 6484.481241500669, 6516.511261655395, 6555.967220163964, 6564.9671751640935, 6565.277819439858, 6661.873000917447, 6666.366695163952, 6712.53012289135, 6736.259011508828, 6755.898661519983, 6449.838754031187, 6476.740930362921, 6548.116004339353, 6548.705308261235, 6589.341065893373, 6326.367363263636, 6434.099226108255, 6473.8705225896165, 6582.946728523413, 6664.233613134552, 6533.346665333429, 6652.900206497004, 6660.933390666225, 6681.465482761465, 6693.631850248283, 6357.364263573791, 6401.775937842153, 6425.261094974137, 6432.678366081771, 6433.324500927335, 6375.171227740364, 6377.681115944277, 6425.8714825704155, 6447.677616119269, 6459.031145328238, 6316.873662526632, 6347.492200624031, 6393.7122829471855, 6418.807435776934, 6432.13166222554, 6343.429091381798, 6386.457151142205, 6503.609783412821, 6535.640539770358, 6585.20977482686, 6177.62934223948, 6323.20959880015, 6328.525360598066, 6338.714757835816, 6340.365963403808], "value": 6060.74327600482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.6389034660269, 877.4077497689058, 879.4547380624014, 883.9657600607293, 889.4707648948876, 37981.24037519248, 38232.61767382325, 41287.38068928961, 41348.37977430337, 41460.58539414605, 39051.804740976324, 39506.0, 39575.208495830135, 39600.80199599005, 39737.80131099348, 7031.718731250757, 7147.642617869085, 7215.0, 7222.783316500513, 7708.614569271514, 7785.41609379296, 7875.212478752136, 7896.80257993549, 7903.960480197619, 7936.6825326986855, 7858.253465920729, 7906.248906353916, 7908.209179082103, 7913.643886025143, 7917.881231781528, 7822.882656760153, 7824.5696486693205, 7851.21487851216, 7862.056553213593, 7863.174366691473, 7711.961440192763, 7720.845583088363, 7796.4932279401655, 7822.374210063182, 7826.413019023539, 38288.0, 38505.80747096275, 38718.0, 38750.22499550021, 38773.41839872404, 3505.789652620851, 3524.1718196223865, 3544.946825797615, 3547.0777597824494, 3547.290541891632, 31217.21956951072, 31421.0, 31438.842805786055, 31457.528137077963, 31530.684693153235, 5141.30592370029, 5222.060029194743, 5267.288915996368, 5292.391374991887, 5363.544098751572, 178956.0, 179535.0, 181518.0, 181695.9999999987, 181779.09110454362, 41704.791476042425, 42873.571264286955, 47801.521984780404, 48324.0, 48447.75776121167, 51330.23004654933, 52246.47753522416, 52276.21585676218, 52309.47690523046, 52423.47576524186, 15793.447229347148, 15946.521604351889, 15983.840161598468, 15988.0, 16000.919995400182, 12674.049446291565, 12677.429515671633, 12695.93652031734, 12696.93651531755, 12697.873021269854, 14119.929400352932, 14192.432302707775, 14293.142411455347, 14337.0, 14374.856251437352, 5710.400407957188, 5737.913931291034, 5746.741396637161, 5852.268466441695, 5871.178035075093, 994.9204063674889, 995.9004099590128, 1011.8633984412011, 1030.4641586375192, 1033.9379637221791, 22538.436539086328, 22677.0, 22916.770832291462, 23004.0, 23071.601694113928, 1103.9282446640943, 1118.0999295566985, 1132.8130858408435, 1133.8525991621036, 1140.4981808004452, 12190.329531875832, 12196.878031219752, 12202.450889709984, 12234.265944043385, 12264.938675306745, 205268.0, 206705.0, 206763.0, 206962.0, 207085.0, 53135.0, 53472.465275346745, 53509.73245133749, 53804.0, 53812.0, 1427.093795439903, 1462.495439073518, 1468.3612628506635, 1469.8750606198594, 1479.7484427647325, 22124.77875221227, 22320.66519002184, 22542.887285564124, 22701.659475108216, 22920.656190156828, 36939.63060369362, 37107.628923710414, 37283.627163728015, 37289.81355093207, 37339.813300933325, 192614.0, 193021.0, 193606.0, 194315.0, 194810.0, 33374.163196128604, 35289.47065794066, 36220.27559448744, 36257.81871090628, 36337.818310908275, 43293.35059974166, 45320.54679453295, 45328.77335613301, 45368.54631453775, 46505.76747116378, 32724.0, 33195.66804331926, 33331.500027499125, 33413.49879751757, 33552.49671254982, 31745.0, 32653.836730817144, 32698.673013269563, 32801.34397312088, 32803.34393312168, 36566.451503228, 37244.441333380564, 37260.950647714635, 37581.0, 37657.0, 31858.68141318557, 32112.35775284528, 32236.355272893943, 32574.674253257162, 32644.0, 23840.973517251226, 23953.281401557982, 24201.273961781175, 24377.0, 24686.506269874862], "value": 17134.594202010452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.7069767674295, 564.2720890051834, 571.2630706388759, 579.9971000145, 583.9824805255842, 22303.0, 22928.88535557322, 23276.534469310605, 23295.650565241493, 23305.883470582645, 23850.0, 24345.87827060862, 24595.508089838193, 25608.871955640243, 25856.22431327063, 6580.670966451682, 6594.8681026379445, 6600.207975043001, 6626.900596491057, 6644.933550664504, 6603.075569420285, 6676.866462670744, 6720.495962802785, 6721.294264102272, 6735.057092007123, 6204.317525072239, 6438.871222575545, 6491.123698300717, 6571.835704107388, 6656.334366563329, 6467.93532064678, 6473.83815404614, 6515.087887695727, 6521.347865213441, 6523.934760652404, 5841.0, 6020.8494787630225, 6024.698765061773, 6034.849128771816, 6056.848578785522, 28208.85895570509, 28670.856645716845, 28860.278493037633, 28936.565951510744, 29017.12948611524, 2075.1491888325713, 2084.8436367272516, 2106.3259756877806, 2107.104480595741, 2110.5989861926187, 18377.724334134866, 18706.81293187064, 18899.62200755991, 18900.149493272696, 18919.33782317626, 2416.9154079607306, 2489.8879550420274, 2495.987520062406, 2505.448801263737, 2508.485760419128, 116558.0, 119404.0, 119781.40109299398, 133707.0, 133909.99999999904, 14330.163374786638, 14614.34235459407, 14658.780118298235, 14967.756082488708, 15094.54716358511, 22869.313920582408, 22979.0, 23057.0, 23089.307320780405, 23164.0, 9828.213742900694, 9844.310898237054, 9905.20758339331, 9914.305998580174, 10045.397276163454, 9086.772830679285, 9117.81764364709, 9194.356395052282, 9199.310051746146, 9234.445933244027, 8900.243479304203, 8999.640014399482, 9246.121618446237, 9305.860412093823, 9369.203617692436, 2641.6037594361, 2642.9867850661008, 2646.113551960115, 2780.471710375022, 2844.6586409630977, 937.6577549194495, 967.2020583019038, 971.5142428785607, 973.090160699748, 973.1971123822874, 19491.610167796563, 19815.30646427397, 19846.0, 20140.295089671792, 20398.0, 1001.1940387987594, 1008.9848652270222, 1015.4161357219629, 1027.1885210683627, 1036.4403222260046, 10832.187585931088, 11123.054540364159, 11155.776884462266, 11177.608783692533, 11194.0, 461387.0, 476058.0, 489047.0, 496344.0, 497100.0, 110118.0, 111206.44396778126, 113379.0, 113497.0, 118676.40661796808, 1108.1024370260116, 1142.0635079235115, 1145.1125377832248, 1146.2893006335958, 1146.5643055638805, 17531.386401475887, 17537.0, 17594.560135996704, 17712.91143544274, 17853.196606153015, 52042.47957520376, 53184.73407632937, 53898.461015389345, 54724.726376367864, 55158.0, 68346.65826670834, 68629.65685171742, 68957.31042689508, 70040.64979675069, 70401.64799175972, 14280.0, 14504.85495145035, 14524.273786310854, 14528.564143075724, 14535.982481226212, 22372.664410034187, 22864.199753008565, 22931.656025159304, 23129.653055204522, 23517.059317627787, 18227.817721822612, 18406.81593184051, 18419.355322563646, 18436.446906592824, 18477.72283415723, 16534.09062501574, 16691.582710432336, 16694.0, 16912.577185569968, 16974.557162641315, 18348.17433215535, 18694.0, 18750.34373796965, 18786.906065469586, 18910.716339255196, 14394.640133996734, 14407.207603581903, 14456.349464273922, 14496.565103046925, 14543.418263269774, 18180.36368727088, 18183.54541136429, 18303.176357063698, 18311.084445777924, 18457.446276611725], "value": 11843.800942686228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.456562809248, 1367.9384427700752, 1403.6631208509957, 1406.022814144169, 1412.682146517033, 14665.266736663165, 15410.22948852557, 15410.61473463164, 15418.845811541882, 15450.381984720598, 15081.773773393408, 15121.0, 15127.924360378183, 15162.620934476643, 15224.391024359013, 2772.986135069322, 2826.4347130573915, 2842.7583655389317, 2857.8428186449737, 2876.0652787844033, 2724.8637568121517, 2732.7540521353076, 2735.179446166152, 2749.766269867064, 2766.640336756219, 2570.884310206045, 2597.8441293522355, 2723.700392956773, 2865.6131422257936, 2869.4404591104744, 2690.4753573053263, 2728.0, 2736.0, 2736.698963114056, 2737.096758069832, 2604.8306860054226, 2644.9471010579873, 2655.030913716499, 2657.7608015278524, 2658.9734102658917, 14608.634784130376, 14965.70068598622, 14971.625709357244, 14978.700425991528, 15012.549623511311, 7487.925120748777, 7741.651625676858, 7746.915431839547, 7785.104712958026, 7786.377089832799, 5419.701916394597, 5553.111502159675, 5709.3434255060365, 5728.484436400744, 5765.913511297334, 1830.1764206107173, 1861.2368928739152, 1898.2881419467699, 1941.3981665683684, 1945.7373254610588, 25173.748262517325, 26150.0, 26379.208623741317, 26396.340091497674, 26430.471390572082, 6706.899396509057, 7103.89344159838, 7139.92901064834, 7159.713611455483, 7183.92816071843, 17010.064446455563, 17043.744343834853, 17120.914395427943, 17158.22787974519, 17205.311787528357, 7185.784426467214, 7448.888266676005, 7595.772126836204, 7677.193894641094, 7680.34717049046, 7137.643117844087, 7231.674574644154, 7290.234525374865, 7301.780946571611, 7303.269673032761, 5101.7704203310195, 5282.603804714585, 5291.894162116736, 5301.946980530222, 5302.814401495929, 1496.8278647955406, 1550.550340401271, 1566.5691934718043, 1567.3103834312865, 1580.5021418253214, 854.2354592639552, 862.607513581319, 881.3389957531851, 883.6023789294843, 887.0685779931047, 7049.4712896532965, 7049.577025378494, 7055.188653304833, 7056.047433596502, 7204.819879503054, 697.8848489999194, 713.9500234983606, 716.4238674915207, 723.1250187273353, 735.3565630073685, 4092.447519584818, 4384.846530371422, 5162.354705661793, 5175.964807038607, 5207.1668533034535, 20250.291239806535, 20765.95489742814, 21185.576288474145, 21577.352679419644, 21652.0, 19598.804011959983, 20883.164673413197, 21073.367798966057, 21441.67837482439, 21483.892580536998, 10482.794478635054, 10638.41488718128, 10686.305390149615, 10784.299020563638, 11004.39475828837, 8225.46534475281, 8296.0, 8329.6668133274, 8339.638419879097, 8407.369447291356, 18292.542686432946, 18451.630967380308, 18974.0512974348, 19046.14292356875, 19129.139188736262, 19260.8073919259, 19304.32434864773, 19369.225230990603, 19761.308354207533, 19886.50283742918, 10827.458627068772, 11052.557897684002, 11097.778044438905, 11108.833367499656, 11111.277766945446, 13073.215607063607, 13095.934520327337, 13196.736065278832, 13210.669733256746, 13215.735685286432, 11240.83138752903, 11443.48504317291, 11509.654710358702, 11549.249298795552, 11714.355710436008, 10880.619178328721, 11054.613088541862, 11236.0, 11265.549378025114, 11311.943440282746, 9304.813903722023, 9338.159565639126, 9356.0, 9373.062693730844, 9402.0, 6844.760433384808, 6954.826129346807, 6965.721371145098, 6969.477289203432, 7097.609631470319, 6829.69266383004, 6926.06498122747, 6959.7216111357, 6967.79096627102, 7185.964070179824], "value": 6531.72723353482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.1928086644026, 505.8330750852217, 519.361185741538, 528.6903981078448, 528.957683385329, 6143.095640351494, 6170.876582468348, 6185.0, 6224.875502489953, 6303.905441418371, 6124.387561243873, 6134.417230363119, 6159.168512250845, 6175.845603859906, 6189.381061893809, 5115.872103197422, 5129.358830146231, 5135.563477104451, 5161.406438259611, 5163.81926632568, 5092.898142037157, 5127.846164615067, 5141.485851414847, 5151.0, 5183.2743415921805, 4721.952780472203, 4861.052094841507, 4863.902721945559, 4899.6815207011605, 5068.797248110071, 4831.734254615994, 4834.347363105989, 4875.317455556225, 4877.3903262092235, 4879.829205977791, 4355.477342718862, 4363.5418281080665, 4363.563643635611, 4408.735475871458, 4413.139437809628, 5863.58954873159, 5899.32157801854, 5978.55160862937, 5993.370696076936, 6004.369541198199, 5518.255035570227, 5552.5280351170195, 5561.77752889884, 5581.720913954286, 5595.328560572757, 6355.745770169187, 6388.361163883621, 6400.2399340181355, 6459.031145328238, 6469.708863101172, 4523.683342166049, 4759.0, 4781.235002399634, 4823.083614113307, 4830.855074347775, 6465.644389558573, 6471.320511346288, 6592.406683398517, 6706.920854535109, 6710.228323742735, 4893.926591101136, 4924.261360795909, 4932.717493451729, 4961.305417241589, 4963.851084467472, 4917.9016419672125, 4923.458419573915, 4963.181075122637, 4989.550940415307, 4989.675671081368, 5459.454054594588, 5464.398916119224, 5526.292116862708, 5547.833564993057, 5610.186522954149, 6466.838329041718, 6498.545101842826, 6514.1531600891585, 6514.73941042353, 6525.282218955911, 1718.1752758675905, 1729.9394521191698, 1737.3832289537286, 1745.764321816564, 1750.64111857069, 1142.5144313666658, 1190.4642910690052, 1193.5822462138183, 1195.450092957232, 1218.6465924881861, 5561.527270181999, 5576.776928922879, 5587.944120558824, 5672.914906276409, 5676.801311954062, 6379.840503987438, 6426.196725409324, 6508.027666109073, 6528.314526974599, 6592.86814263712, 5532.778688852401, 5579.860503487364, 5643.322801263875, 5652.180433837153, 5656.519195868315, 3386.72906167506, 3452.5166476693284, 3464.133966508373, 3497.9125521861647, 3501.2472318451146, 6243.594166379171, 6332.303446620868, 6373.426391624776, 6394.9711681640265, 6423.871522569522, 6707.3963343298365, 6734.427573656294, 6739.93260067393, 6798.728050878009, 6820.35206655367, 6267.905981410191, 6330.39861213184, 6444.2266927968, 6492.577982431221, 6495.902561461582, 6100.276542022364, 6340.207474065742, 6519.380658837403, 6572.502449069323, 6578.243501997332, 6399.488040956805, 6524.771632992823, 6548.345165483413, 6552.770653027121, 6559.770408035696, 6136.693165341626, 6182.28903676083, 6190.164327815687, 6331.620102793847, 6331.715072821642, 4874.926876096933, 4908.165611845923, 4921.803127874988, 4951.306817045688, 4960.379952505937, 6271.78048768291, 6482.643454610042, 6534.150560427114, 6586.506012049212, 6605.003972596702, 6152.477039451518, 6254.6247225166635, 6273.341299163522, 6350.729854029305, 6355.616643758591, 6240.28236752761, 6259.530535209787, 6279.434850863444, 6366.331535188739, 6370.299267080525, 6224.62652240867, 6312.936870631235, 6346.238451385863, 6388.68056597159, 6400.679966001589, 6375.968120159369, 6395.264544577433, 6420.454261387835, 6428.164338635947, 6428.967855160694, 6121.908171377522, 6165.106059621419, 6208.596441231305, 6215.254169499689, 6249.500039996698], "value": 4955.846352714815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.2229105260529, 920.1304766995188, 931.4550987672211, 938.0759951447827, 947.209080417851, 18475.35336263231, 18921.337753178606, 18930.14814333355, 18953.526161845944, 19064.523386915316, 17395.82604173958, 17701.0264435456, 17758.82241177588, 17960.191791369387, 18002.549936251602, 896.6547879066558, 921.7004473546124, 928.0904713380891, 929.7071422501924, 932.3194068330089, 941.7598512379334, 949.2832911152105, 955.1308309438413, 955.4171955107379, 955.9091886270793, 955.4840386191448, 981.7741919358551, 987.4963768478092, 989.0554520432969, 993.8509223616443, 973.4986481961795, 977.4770497783652, 983.0611765763679, 984.527426835116, 986.7187851462298, 695.7808290388512, 716.9641517924083, 719.7085180501905, 720.344486517272, 723.9312265334785, 18637.16132774015, 18639.161237744334, 18702.62594748111, 18770.249190032384, 18774.0, 18710.532236694056, 19022.0, 19793.30723424673, 20312.882791446464, 20469.8976505118, 16892.577685557837, 17095.0, 17175.0, 17265.0, 17603.911980440145, 3738.962610373916, 3815.4086116651965, 3825.2731980923813, 3829.4447305140875, 3832.0419895026243, 100642.49678751633, 102884.48557757238, 139055.0, 143563.28218358947, 148874.25562872118, 17733.911330443523, 17844.55388615295, 18050.458486245432, 18087.819121808614, 18210.45368638943, 31320.843395782875, 31657.05028849138, 32043.839780800947, 32369.190770230463, 32391.35217295641, 9262.861057084148, 9429.292803039662, 9459.290553208399, 9469.573869175903, 9495.525223738923, 4453.0648563801315, 4492.573205545468, 4512.0, 4528.773561321987, 4541.455025396974, 4907.288443175791, 4969.503049695074, 4993.300937868701, 5056.570191533688, 5083.364579427572, 1058.8570542976754, 1060.6181774561153, 1084.8752393474851, 1085.115630760943, 1091.1161958813386, 630.7729217481703, 632.358156471173, 645.8159424563977, 650.187265917603, 654.2214764430313, 11763.353015584225, 12017.0, 12856.807147892789, 12952.546660866825, 13044.0, 607.9483243924316, 614.4500671898626, 618.0204376063899, 622.551762730833, 623.3392603839853, 5465.535429488458, 5622.100463925753, 5703.486686198262, 5772.7113644317615, 5773.826785196451, 115522.0, 123286.0, 124910.0, 125096.0, 127296.0, 106812.46593766981, 106834.0, 108974.45512772385, 109607.45196273968, 111402.44298778454, 92953.53523232341, 93626.0, 96023.0, 96403.51798240964, 96840.54739178918, 10133.695989120339, 10219.948900255451, 10477.476126193507, 10530.736731581772, 10655.946720266658, 43180.352294716235, 44611.33083003823, 44755.0, 45401.545984539734, 45448.091038179715, 57119.0, 57595.71202143963, 57699.0, 57966.0, 58562.12156817566, 15963.760543591623, 16012.919935400249, 16053.759193612339, 16111.0, 16350.836491635408, 16118.2746776393, 16143.67712645764, 16446.342146314015, 16457.0, 16801.243944022794, 15631.84368156304, 15909.840901590836, 16051.598710032342, 16060.196990150213, 16178.838211617733, 15972.041677499386, 16003.599910001878, 16050.357985680908, 16101.838981610033, 16340.591485212964, 15533.223338833239, 15549.84450155484, 15686.764698529303, 15716.0, 15728.685426291639, 10037.146842518176, 10053.246006549392, 10210.489475526343, 10346.430946297725, 10348.896511035095, 11802.291862488279, 11913.285202887855, 12049.277043377426, 12134.575289864812, 12175.33035683046], "value": 8788.684287677914, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 109.0, 111.0, 111.0, 114.0, 108.0, 114.0, 112.0, 114.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 127.0, 117.0, 125.0, 118.0, 120.0, 125.0, 117.0, 122.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 169.0, 167.0, 166.0, 167.0, 166.0, 169.0, 165.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 79.0, 82.0, 77.0, 78.0, 74.0, 74.0, 75.0, 84.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 79.0, 84.0, 81.0, 84.0, 79.0, 84.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 128.0, 114.0, 115.0, 119.0, 114.0, 118.0, 116.0, 112.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 150.0, 150.0, 153.0, 149.0, 149.0, 149.0, 155.0, 148.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 98.0, 98.0, 98.0, 100.0, 97.0, 97.0, 96.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 62.0, 55.0, 54.0, 55.0, 55.0, 53.0, 65.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 46.0, 47.0, 39.0, 48.0, 42.0, 39.0, 39.0, 38.0, 39.0], "value": 42.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 74.0, 75.0, 79.0, 83.0, 79.0, 90.0, 77.0, 75.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 125.0, 116.0, 110.0, 113.0, 112.0, 117.0, 113.0, 119.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 172.0, 170.0, 171.0, 172.0, 188.0, 170.0, 182.0, 172.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 64.0, 66.0, 70.0, 66.0, 71.0, 65.0, 69.0, 67.0], "value": 67.4, "unit": "score"}]}]} 03:43:11 INFO - Return code: 0 03:43:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:11 INFO - # TBPL SUCCESS # 03:43:11 INFO - Running post-action listener: _package_coverage_data 03:43:11 INFO - Running post-action listener: _resource_record_post_action 03:43:11 INFO - [mozharness: 2017-09-16 10:43:11.994191Z] Finished run-tests step (success) 03:43:11 INFO - Running post-run listener: _resource_record_post_run 03:43:12 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 286720; Write bytes: 344465408; Read time: 212; Write time: 223884 03:43:12 INFO - TinderboxPrint: CPU usage
13.3% 03:43:12 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 212 03:43:12 INFO - TinderboxPrint: I/O write bytes / time
344,465,408 / 223,884 03:43:12 INFO - TinderboxPrint: CPU idle
8,251.9 (86.7%) 03:43:12 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 03:43:12 INFO - TinderboxPrint: Swap in / out
0 / 0 03:43:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13512704; Read time: 0; Write time: 1936 03:43:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:43:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 282624; Write bytes: 330952704; Read time: 196; Write time: 221948 03:43:12 INFO - Running post-run listener: _upload_blobber_files 03:43:12 INFO - Blob upload gear active. 03:43:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:43:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:20 INFO - (blobuploader) - INFO - Done attempting. 03:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:21 INFO - (blobuploader) - INFO - Done attempting. 03:43:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:43:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:43:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:22 INFO - (blobuploader) - INFO - Done attempting. 03:43:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:23 INFO - (blobuploader) - INFO - Done attempting. 03:43:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:23 INFO - Return code: 0 03:43:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/678c3ef192e08ce82c6ccd85180b3ccd6e4b7c5f6c2ddb3e38f821fdbee12ca72c3fe589a862732c6e69bb16b7b41a87de80e07a51e89353b5b0545165e7739f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b3d7713f516fe88a6d938f69044215a66852e55b6a846f622784061881bfb22e0d8270e49ed32fc2aa116d23563d0d191f1ab3fc23bf6aa043d393116435384", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6868330805a2bad5b697ce4255df4710f4f439033ed494d55ebbb92c1c1d55cb8613bd5a97b2af7d964639d32857f1bf069d0983063fda70f6235810b6448d2d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716bffea2c73dbe29a45e5c21d011e29dfe119a85819f38ee24e33bcd067b5b37d257f428749afa41a7bade281868bc0d04d66e962c28dcbef92890cf195d292"} 03:43:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:23 INFO - Contents: 03:43:23 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/678c3ef192e08ce82c6ccd85180b3ccd6e4b7c5f6c2ddb3e38f821fdbee12ca72c3fe589a862732c6e69bb16b7b41a87de80e07a51e89353b5b0545165e7739f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b3d7713f516fe88a6d938f69044215a66852e55b6a846f622784061881bfb22e0d8270e49ed32fc2aa116d23563d0d191f1ab3fc23bf6aa043d393116435384", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6868330805a2bad5b697ce4255df4710f4f439033ed494d55ebbb92c1c1d55cb8613bd5a97b2af7d964639d32857f1bf069d0983063fda70f6235810b6448d2d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716bffea2c73dbe29a45e5c21d011e29dfe119a85819f38ee24e33bcd067b5b37d257f428749afa41a7bade281868bc0d04d66e962c28dcbef92890cf195d292"} 03:43:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:23 INFO - Copying logs to upload dir... 03:43:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.793112 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-16 03:43:23.658848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:23.666278) ========= 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=cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759 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/678c3ef192e08ce82c6ccd85180b3ccd6e4b7c5f6c2ddb3e38f821fdbee12ca72c3fe589a862732c6e69bb16b7b41a87de80e07a51e89353b5b0545165e7739f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b3d7713f516fe88a6d938f69044215a66852e55b6a846f622784061881bfb22e0d8270e49ed32fc2aa116d23563d0d191f1ab3fc23bf6aa043d393116435384", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6868330805a2bad5b697ce4255df4710f4f439033ed494d55ebbb92c1c1d55cb8613bd5a97b2af7d964639d32857f1bf069d0983063fda70f6235810b6448d2d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716bffea2c73dbe29a45e5c21d011e29dfe119a85819f38ee24e33bcd067b5b37d257f428749afa41a7bade281868bc0d04d66e962c28dcbef92890cf195d292"} build_url:https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/678c3ef192e08ce82c6ccd85180b3ccd6e4b7c5f6c2ddb3e38f821fdbee12ca72c3fe589a862732c6e69bb16b7b41a87de80e07a51e89353b5b0545165e7739f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b3d7713f516fe88a6d938f69044215a66852e55b6a846f622784061881bfb22e0d8270e49ed32fc2aa116d23563d0d191f1ab3fc23bf6aa043d393116435384", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6868330805a2bad5b697ce4255df4710f4f439033ed494d55ebbb92c1c1d55cb8613bd5a97b2af7d964639d32857f1bf069d0983063fda70f6235810b6448d2d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716bffea2c73dbe29a45e5c21d011e29dfe119a85819f38ee24e33bcd067b5b37d257f428749afa41a7bade281868bc0d04d66e962c28dcbef92890cf195d292"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:23.697222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:23.697534) ========= 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=cbe409c6de289db6ac707de3000001d4-1505557137.645789-1956939759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:23.778764) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:43:23.782083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:43:23.782389) ========= ========= Total master_lag: 0.26 =========