builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-006 starttime: 1504893803.01 results: success (0) revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.005580) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.006042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.006318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.035515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.035907) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 11:03:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-09-08 11:03:23 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.218608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.218926) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016373 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.272153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 11:03:23.272509) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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=e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 11:03:23,326 truncating revision to first 12 chars 2017-09-08 11:03:23,326 Setting DEBUG logging. 2017-09-08 11:03:23,326 attempt 1/10 2017-09-08 11:03:23,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d0288c29165?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 11:03:24,321 unpacking tar archive at: mozilla-central-6d0288c29165/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323301 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-08 11:03:24.613415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:24.613724) ========= script_repo_revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:24.614118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:24.614384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:24.634551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-08 11:03:24.634815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:24 INFO - MultiFileLogger online at 20170908 11:03:24 in /builds/slave/test 11:03:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:03:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:24 INFO - {'append_to_log': False, 11:03:24 INFO - 'base_work_dir': '/builds/slave/test', 11:03:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:03:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:24 INFO - 'branch': 'Firefox-Non-PGO', 11:03:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:24 INFO - 'code_coverage': False, 11:03:24 INFO - 'config_files': ('talos/linux_config.py',), 11:03:24 INFO - 'default_actions': ('clobber', 11:03:24 INFO - 'read-buildbot-config', 11:03:24 INFO - 'download-and-extract', 11:03:24 INFO - 'populate-webroot', 11:03:24 INFO - 'create-virtualenv', 11:03:24 INFO - 'install', 11:03:24 INFO - 'setup-mitmproxy', 11:03:24 INFO - 'run-tests'), 11:03:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:24 INFO - 'disable_ccov_upload': False, 11:03:24 INFO - 'disable_stylo': False, 11:03:24 INFO - 'download_minidump_stackwalk': True, 11:03:24 INFO - 'download_symbols': 'ondemand', 11:03:24 INFO - 'enable_stylo': False, 11:03:24 INFO - 'enable_webrender': False, 11:03:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:03:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:24 INFO - 'gecko_profile': False, 11:03:24 INFO - 'gecko_profile_interval': 0, 11:03:24 INFO - 'installer_path': 'installer.exe', 11:03:24 INFO - 'log_level': 'info', 11:03:24 INFO - 'log_name': 'talos', 11:03:24 INFO - 'log_to_console': True, 11:03:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:24 INFO - 'opt_config_files': (), 11:03:24 INFO - 'pip_index': False, 11:03:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:03:24 INFO - 'system_bits': '32', 11:03:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:24 INFO - 'title': 'talos-linux64-ix-006', 11:03:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:24 INFO - 'use_talos_json': True, 11:03:24 INFO - 'verify': 'False', 11:03:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:24 INFO - 'work_dir': 'build'} 11:03:24 INFO - [mozharness: 2017-09-08 18:03:24.827841Z] Running clobber step. 11:03:24 INFO - Running pre-action listener: _resource_record_pre_action 11:03:24 INFO - Running main action method: clobber 11:03:24 INFO - rmtree: /builds/slave/test/build 11:03:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:26 INFO - Running post-action listener: _resource_record_post_action 11:03:26 INFO - [mozharness: 2017-09-08 18:03:26.374477Z] Finished clobber step (success) 11:03:26 INFO - [mozharness: 2017-09-08 18:03:26.374574Z] Running read-buildbot-config step. 11:03:26 INFO - Running pre-action listener: _resource_record_pre_action 11:03:26 INFO - Running main action method: read_buildbot_config 11:03:26 INFO - Using buildbot properties: 11:03:26 INFO - { 11:03:26 INFO - "project": "", 11:03:26 INFO - "product": "firefox", 11:03:26 INFO - "who": "ffxbld@noreply.mozilla.org", 11:03:26 INFO - "installer_path": "public/build/target.tar.bz2", 11:03:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:03:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:03:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:03:26 INFO - "stage_platform": "linux64", 11:03:26 INFO - "basedir": "/builds/slave/test", 11:03:26 INFO - "buildnumber": 3, 11:03:26 INFO - "platform": "ubuntu64_hw", 11:03:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:26 INFO - "slavebuilddir": "test", 11:03:26 INFO - "taskId": "Z1gyyFLgSMa6_ZI0ZtujXw", 11:03:26 INFO - "branch": "mozilla-central", 11:03:26 INFO - "script_repo_revision": "production", 11:03:26 INFO - "revision": "6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b", 11:03:26 INFO - "slavename": "talos-linux64-ix-006", 11:03:26 INFO - "repo_path": "mozilla-central" 11:03:26 INFO - } 11:03:26 INFO - Finding installer, test and symbols from parent task. 11:03:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z1gyyFLgSMa6_ZI0ZtujXw'}, attempt #1 11:03:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z1gyyFLgSMa6_ZI0ZtujXw'}, attempt #1 11:03:27 INFO - Task dependencies: RlzMfz8tRFW8DsiiCEg_WA 11:03:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA'}, attempt #1 11:03:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip 11:03:28 INFO - Running post-action listener: _resource_record_post_action 11:03:28 INFO - [mozharness: 2017-09-08 18:03:28.012413Z] Finished read-buildbot-config step (success) 11:03:28 INFO - [mozharness: 2017-09-08 18:03:28.012723Z] Running download-and-extract step. 11:03:28 INFO - Running pre-action listener: _resource_record_pre_action 11:03:28 INFO - Running main action method: download_and_extract 11:03:28 INFO - mkdir: /builds/slave/test/build/tests 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:28 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:28 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:03:28 INFO - Downloaded 989 bytes. 11:03:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:03:28 INFO - Using the following test package requirements: 11:03:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:03:28 INFO - u'common': [u'target.common.tests.zip'], 11:03:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:03:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:03:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:03:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:03:28 INFO - u'mozbase': [u'target.common.tests.zip'], 11:03:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:03:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:03:28 INFO - u'web-platform': [u'target.common.tests.zip', 11:03:28 INFO - u'target.web-platform.tests.tar.gz'], 11:03:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:03:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:03:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip 11:03:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:28 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip into memory 11:03:30 INFO - Content-Length response header: 55023640 11:03:30 INFO - Bytes received: 55023640 11:03:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip 11:03:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:03:41 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip into memory 11:03:42 INFO - Content-Length response header: 14496665 11:03:42 INFO - Bytes received: 14496665 11:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:42 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:03:44 INFO - Downloaded 62833296 bytes. 11:03:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:44 INFO - mkdir: /builds/slave/test/properties 11:03:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:44 INFO - Contents: 11:03:44 INFO - build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:44 INFO - Running post-action listener: _resource_record_post_action 11:03:44 INFO - Running post-action listener: find_tests_for_verification 11:03:44 INFO - Running post-action listener: set_extra_try_arguments 11:03:44 INFO - [mozharness: 2017-09-08 18:03:44.829162Z] Finished download-and-extract step (success) 11:03:44 INFO - [mozharness: 2017-09-08 18:03:44.829396Z] Running populate-webroot step. 11:03:44 INFO - Running pre-action listener: _resource_record_pre_action 11:03:44 INFO - Running main action method: populate_webroot 11:03:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['tresize', 11:03:44 INFO - 'tcanvasmark']}, 11:03:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['dromaeo_css', 11:03:44 INFO - 'kraken']}, 11:03:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'tests': ['damp', 'tps']}, 11:03:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['damp', 'tps']}, 11:03:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['dromaeo_dom']}, 11:03:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:03:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['basic_compositor_video', 11:03:44 INFO - 'glvideo']}, 11:03:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['ts_paint_webext', 11:03:44 INFO - 'tp5o_webext']}, 11:03:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:44 INFO - 'ts_paint', 11:03:44 INFO - 'tpaint', 11:03:44 INFO - 'sessionrestore', 11:03:44 INFO - 'sessionrestore_many_windows', 11:03:44 INFO - 'sessionrestore_no_auto_restore', 11:03:44 INFO - 'tabpaint']}, 11:03:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['a11yr', 11:03:44 INFO - 'ts_paint', 11:03:44 INFO - 'tpaint', 11:03:44 INFO - 'sessionrestore', 11:03:44 INFO - 'sessionrestore_many_windows', 11:03:44 INFO - 'sessionrestore_no_auto_restore', 11:03:44 INFO - 'tabpaint']}, 11:03:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:03:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:03:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['bloom_basic_singleton']}, 11:03:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['bloom_basic']}, 11:03:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:44 INFO - 'tsvgr_opacity', 11:03:44 INFO - 'tart', 11:03:44 INFO - 'tscrollx', 11:03:44 INFO - 'tsvg_static']}, 11:03:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['tsvgx', 11:03:44 INFO - 'tsvgr_opacity', 11:03:44 INFO - 'tart', 11:03:44 INFO - 'tscrollx', 11:03:44 INFO - 'tsvg_static']}, 11:03:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:03:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'talos_options': ['--disable-stylo'], 11:03:44 INFO - 'tests': ['tp5o']}, 11:03:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:44 INFO - 'talos_options': ['--mitmproxy', 11:03:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:44 INFO - '--firstNonBlankPaint'], 11:03:44 INFO - 'tests': ['tp6_google', 11:03:44 INFO - 'tp6_youtube', 11:03:44 INFO - 'tp6_amazon', 11:03:44 INFO - 'tp6_facebook']}, 11:03:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:44 INFO - 'talos_options': ['--disable-stylo', 11:03:44 INFO - '--mitmproxy', 11:03:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:44 INFO - '--firstNonBlankPaint'], 11:03:44 INFO - 'tests': ['tp6_google', 11:03:44 INFO - 'tp6_youtube', 11:03:44 INFO - 'tp6_amazon', 11:03:44 INFO - 'tp6_facebook']}, 11:03:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:44 INFO - 'talos_options': ['--stylo-threads=1', 11:03:44 INFO - '--mitmproxy', 11:03:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:44 INFO - '--firstNonBlankPaint'], 11:03:44 INFO - 'tests': ['tp6_google', 11:03:44 INFO - 'tp6_youtube', 11:03:44 INFO - 'tp6_amazon', 11:03:44 INFO - 'tp6_facebook']}, 11:03:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'talos_options': ['--xperf_path', 11:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:44 INFO - 'tests': ['tp5n']}, 11:03:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:44 INFO - 'talos_options': ['--disable-stylo', 11:03:44 INFO - '--xperf_path', 11:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:44 INFO - 'tests': ['tp5n']}}} 11:03:44 INFO - Running post-action listener: _resource_record_post_action 11:03:44 INFO - [mozharness: 2017-09-08 18:03:44.854332Z] Finished populate-webroot step (success) 11:03:44 INFO - [mozharness: 2017-09-08 18:03:44.854478Z] Running create-virtualenv step. 11:03:44 INFO - Running pre-action listener: _resource_record_pre_action 11:03:44 INFO - Running main action method: create_virtualenv 11:03:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:03:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:03:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:03:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:45 INFO - Installing pip...............done. 11:03:45 INFO - Return code: 0 11:03:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:03:45 INFO - Reading from file tmpfile_stdout 11:03:45 INFO - Output received: 11:03:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:03:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:45 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')]} 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:45 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')]} 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:45 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:45 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 11:03:45 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 11:03:45 INFO - Using env: {'DISPLAY': ':0', 11:03:45 INFO - 'HOME': '/home/cltbld', 11:03:45 INFO - 'LANG': 'en_US.UTF-8', 11:03:45 INFO - 'LANGUAGE': 'en_US:en', 11:03:45 INFO - 'LOGNAME': 'cltbld', 11:03:45 INFO - 'MAIL': '/var/mail/cltbld', 11:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:45 INFO - 'MOZ_NO_REMOTE': '1', 11:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:45 INFO - 'NO_EM_RESTART': '1', 11:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:45 INFO - 'PWD': '/builds/slave/test', 11:03:45 INFO - 'SHELL': '/bin/bash', 11:03:45 INFO - 'SHLVL': '1', 11:03:45 INFO - 'TERM': 'linux', 11:03:45 INFO - 'TMOUT': '86400', 11:03:45 INFO - 'USER': 'cltbld', 11:03:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:45 INFO - '_': '/tools/buildbot/bin/python'} 11:03:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:03:47 INFO - Downloading/unpacking pip>=1.5 11:03:47 INFO - Running setup.py egg_info for package pip 11:03:47 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:47 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:47 INFO - Installing collected packages: pip 11:03:47 INFO - Found existing installation: pip 1.1 11:03:47 INFO - Uninstalling pip: 11:03:47 INFO - Successfully uninstalled pip 11:03:47 INFO - Running setup.py install for pip 11:03:47 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:47 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:03:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:03:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:03:47 INFO - Successfully installed pip 11:03:47 INFO - Cleaning up... 11:03:47 INFO - Return code: 0 11:03:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03:47 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')]} 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:47 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')]} 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:47 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:47 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 11:03:47 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 11:03:47 INFO - Using env: {'DISPLAY': ':0', 11:03:47 INFO - 'HOME': '/home/cltbld', 11:03:47 INFO - 'LANG': 'en_US.UTF-8', 11:03:47 INFO - 'LANGUAGE': 'en_US:en', 11:03:47 INFO - 'LOGNAME': 'cltbld', 11:03:47 INFO - 'MAIL': '/var/mail/cltbld', 11:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:47 INFO - 'MOZ_NO_REMOTE': '1', 11:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:47 INFO - 'NO_EM_RESTART': '1', 11:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:47 INFO - 'PWD': '/builds/slave/test', 11:03:47 INFO - 'SHELL': '/bin/bash', 11:03:47 INFO - 'SHLVL': '1', 11:03:47 INFO - 'TERM': 'linux', 11:03:47 INFO - 'TMOUT': '86400', 11:03:47 INFO - 'USER': 'cltbld', 11:03:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:47 INFO - '_': '/tools/buildbot/bin/python'} 11:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:47 INFO - Downloading/unpacking psutil>=3.1.1 11:03:47 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 11:03:47 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 11:03:47 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 11:03:47 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 11:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:48 INFO - Installing collected packages: psutil 11:03:48 INFO - Running setup.py install for psutil 11:03:48 INFO - building 'psutil._psutil_linux' extension 11:03:48 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 11:03:48 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 11:03:48 INFO - building 'psutil._psutil_posix' extension 11:03:48 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 11:03:48 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 11:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:49 INFO - Successfully installed psutil 11:03:49 INFO - Cleaning up... 11:03:49 INFO - Return code: 0 11:03:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:03:49 INFO - Using env: {'DISPLAY': ':0', 11:03:49 INFO - 'HOME': '/home/cltbld', 11:03:49 INFO - 'LANG': 'en_US.UTF-8', 11:03:49 INFO - 'LANGUAGE': 'en_US:en', 11:03:49 INFO - 'LOGNAME': 'cltbld', 11:03:49 INFO - 'MAIL': '/var/mail/cltbld', 11:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:49 INFO - 'MOZ_NO_REMOTE': '1', 11:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:49 INFO - 'NO_EM_RESTART': '1', 11:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:49 INFO - 'PWD': '/builds/slave/test', 11:03:49 INFO - 'SHELL': '/bin/bash', 11:03:49 INFO - 'SHLVL': '1', 11:03:49 INFO - 'TERM': 'linux', 11:03:49 INFO - 'TMOUT': '86400', 11:03:49 INFO - 'USER': 'cltbld', 11:03:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:49 INFO - '_': '/tools/buildbot/bin/python'} 11:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03:49 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 11:03:49 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 11:03:49 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 11:03:49 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 11:03:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:50 INFO - Installing collected packages: mozsystemmonitor 11:03:50 INFO - Running setup.py install for mozsystemmonitor 11:03:50 INFO - Successfully installed mozsystemmonitor 11:03:50 INFO - Cleaning up... 11:03:51 INFO - Return code: 0 11:03:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03:51 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')]} 11:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:51 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')]} 11:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:51 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:51 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 11:03:51 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 11:03:51 INFO - Using env: {'DISPLAY': ':0', 11:03:51 INFO - 'HOME': '/home/cltbld', 11:03:51 INFO - 'LANG': 'en_US.UTF-8', 11:03:51 INFO - 'LANGUAGE': 'en_US:en', 11:03:51 INFO - 'LOGNAME': 'cltbld', 11:03:51 INFO - 'MAIL': '/var/mail/cltbld', 11:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:51 INFO - 'MOZ_NO_REMOTE': '1', 11:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:51 INFO - 'NO_EM_RESTART': '1', 11:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:51 INFO - 'PWD': '/builds/slave/test', 11:03:51 INFO - 'SHELL': '/bin/bash', 11:03:51 INFO - 'SHLVL': '1', 11:03:51 INFO - 'TERM': 'linux', 11:03:51 INFO - 'TMOUT': '86400', 11:03:51 INFO - 'USER': 'cltbld', 11:03:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:51 INFO - '_': '/tools/buildbot/bin/python'} 11:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:51 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 11:03:51 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 11:03:51 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 11:03:51 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 11:03:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:52 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 11:03:52 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 11:03:52 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 11:03:52 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 11:03:52 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:52 INFO - warning: no files found matching '*.txt' 11:03:52 INFO - no previously-included directories found matching 'build' 11:03:52 INFO - no previously-included directories found matching 'dist' 11:03:52 INFO - no previously-included directories found matching '.git*' 11:03:52 INFO - Installing collected packages: jsonschema, functools32 11:03:53 INFO - Running setup.py install for functools32 11:03:53 INFO - warning: no files found matching '*.txt' 11:03:53 INFO - no previously-included directories found matching 'build' 11:03:53 INFO - no previously-included directories found matching 'dist' 11:03:53 INFO - no previously-included directories found matching '.git*' 11:03:53 INFO - Successfully installed jsonschema functools32 11:03:53 INFO - Cleaning up... 11:03:53 INFO - Return code: 0 11:03:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:53 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:53 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 11:03:53 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 11:03:53 INFO - Using env: {'DISPLAY': ':0', 11:03:53 INFO - 'HOME': '/home/cltbld', 11:03:53 INFO - 'LANG': 'en_US.UTF-8', 11:03:53 INFO - 'LANGUAGE': 'en_US:en', 11:03:53 INFO - 'LOGNAME': 'cltbld', 11:03:53 INFO - 'MAIL': '/var/mail/cltbld', 11:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:53 INFO - 'MOZ_NO_REMOTE': '1', 11:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:53 INFO - 'NO_EM_RESTART': '1', 11:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:53 INFO - 'PWD': '/builds/slave/test', 11:03:53 INFO - 'SHELL': '/bin/bash', 11:03:53 INFO - 'SHLVL': '1', 11:03:53 INFO - 'TERM': 'linux', 11:03:53 INFO - 'TMOUT': '86400', 11:03:53 INFO - 'USER': 'cltbld', 11:03:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:53 INFO - '_': '/tools/buildbot/bin/python'} 11:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:03:53 INFO - Cleaning up... 11:03:53 INFO - Return code: 0 11:03:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:53 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:53 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 11:03:53 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 11:03:53 INFO - Using env: {'DISPLAY': ':0', 11:03:53 INFO - 'HOME': '/home/cltbld', 11:03:53 INFO - 'LANG': 'en_US.UTF-8', 11:03:53 INFO - 'LANGUAGE': 'en_US:en', 11:03:53 INFO - 'LOGNAME': 'cltbld', 11:03:53 INFO - 'MAIL': '/var/mail/cltbld', 11:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:53 INFO - 'MOZ_NO_REMOTE': '1', 11:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:53 INFO - 'NO_EM_RESTART': '1', 11:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:53 INFO - 'PWD': '/builds/slave/test', 11:03:53 INFO - 'SHELL': '/bin/bash', 11:03:53 INFO - 'SHLVL': '1', 11:03:53 INFO - 'TERM': 'linux', 11:03:53 INFO - 'TMOUT': '86400', 11:03:53 INFO - 'USER': 'cltbld', 11:03:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:53 INFO - '_': '/tools/buildbot/bin/python'} 11:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:53 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 11:03:53 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 11:03:53 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 11:03:53 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 11:03:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:54 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 11:03:54 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 11:03:54 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 11:03:54 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 11:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:55 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 11:03:55 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 11:03:55 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 11:03:55 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 11:03:55 INFO - Downloading docopt-0.6.1.tar.gz 11:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:55 INFO - Running setup.py install for blobuploader 11:03:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:55 INFO - Running setup.py install for requests 11:03:55 INFO - Running setup.py install for docopt 11:03:55 INFO - Successfully installed blobuploader requests docopt 11:03:55 INFO - Cleaning up... 11:03:55 INFO - Return code: 0 11:03:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:55 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:55 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 11:03:55 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 11:03:55 INFO - Using env: {'DISPLAY': ':0', 11:03:55 INFO - 'HOME': '/home/cltbld', 11:03:55 INFO - 'LANG': 'en_US.UTF-8', 11:03:55 INFO - 'LANGUAGE': 'en_US:en', 11:03:55 INFO - 'LOGNAME': 'cltbld', 11:03:55 INFO - 'MAIL': '/var/mail/cltbld', 11:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:55 INFO - 'MOZ_NO_REMOTE': '1', 11:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:55 INFO - 'NO_EM_RESTART': '1', 11:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:55 INFO - 'PWD': '/builds/slave/test', 11:03:55 INFO - 'SHELL': '/bin/bash', 11:03:55 INFO - 'SHLVL': '1', 11:03:55 INFO - 'TERM': 'linux', 11:03:55 INFO - 'TMOUT': '86400', 11:03:55 INFO - 'USER': 'cltbld', 11:03:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:55 INFO - '_': '/tools/buildbot/bin/python'} 11:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:56 INFO - Running setup.py (path:/tmp/pip-aLtJOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:56 INFO - Running setup.py (path:/tmp/pip-AA_fgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:56 INFO - Running setup.py (path:/tmp/pip-g3ALeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:56 INFO - Running setup.py (path:/tmp/pip-UqGlDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:56 INFO - Running setup.py (path:/tmp/pip-JeJxbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:56 INFO - Running setup.py (path:/tmp/pip-uW98O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:56 INFO - Running setup.py (path:/tmp/pip-j8x40K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:56 INFO - Running setup.py (path:/tmp/pip-GgQ9BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:56 INFO - Running setup.py (path:/tmp/pip-Filto6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:56 INFO - Running setup.py (path:/tmp/pip-4R3STb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:56 INFO - Running setup.py (path:/tmp/pip-RIbX36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:56 INFO - Running setup.py (path:/tmp/pip-JpYjWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:56 INFO - Running setup.py (path:/tmp/pip-eERo7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:56 INFO - Running setup.py (path:/tmp/pip-8fs_8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:57 INFO - Running setup.py (path:/tmp/pip-7ynQyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:57 INFO - Running setup.py (path:/tmp/pip-EkVASs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:57 INFO - Running setup.py (path:/tmp/pip-tEISxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:57 INFO - Running setup.py install for manifestparser 11:03:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Running setup.py install for mozcrash 11:03:57 INFO - Running setup.py install for mozdebug 11:03:57 INFO - Running setup.py install for mozdevice 11:03:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Running setup.py install for mozfile 11:03:57 INFO - Running setup.py install for mozhttpd 11:03:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Running setup.py install for mozinfo 11:03:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:57 INFO - Running setup.py install for mozInstall 11:03:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Running setup.py install for mozleak 11:03:58 INFO - Running setup.py install for mozlog 11:03:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Running setup.py install for moznetwork 11:03:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Running setup.py install for mozprocess 11:03:58 INFO - Running setup.py install for mozprofile 11:03:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Running setup.py install for mozrunner 11:03:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:58 INFO - Running setup.py install for mozscreenshot 11:03:58 INFO - Running setup.py install for moztest 11:03:58 INFO - Running setup.py install for mozversion 11:03:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:59 INFO - Cleaning up... 11:03:59 INFO - Return code: 0 11:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03: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')]} 11:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:59 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:03:59 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 11:03:59 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 11:03:59 INFO - Using env: {'DISPLAY': ':0', 11:03:59 INFO - 'HOME': '/home/cltbld', 11:03:59 INFO - 'LANG': 'en_US.UTF-8', 11:03:59 INFO - 'LANGUAGE': 'en_US:en', 11:03:59 INFO - 'LOGNAME': 'cltbld', 11:03:59 INFO - 'MAIL': '/var/mail/cltbld', 11:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:59 INFO - 'MOZ_NO_REMOTE': '1', 11:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:59 INFO - 'NO_EM_RESTART': '1', 11:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:59 INFO - 'PWD': '/builds/slave/test', 11:03:59 INFO - 'SHELL': '/bin/bash', 11:03:59 INFO - 'SHLVL': '1', 11:03:59 INFO - 'TERM': 'linux', 11:03:59 INFO - 'TMOUT': '86400', 11:03:59 INFO - 'USER': 'cltbld', 11:03:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:59 INFO - '_': '/tools/buildbot/bin/python'} 11:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:59 INFO - Running setup.py (path:/tmp/pip-6Qh_Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:59 INFO - Running setup.py (path:/tmp/pip-s1sCPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:59 INFO - Running setup.py (path:/tmp/pip-FMlwHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:59 INFO - Running setup.py (path:/tmp/pip-Ay69dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:59 INFO - Running setup.py (path:/tmp/pip-7LKF12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:59 INFO - Running setup.py (path:/tmp/pip-hkdCBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:59 INFO - Running setup.py (path:/tmp/pip-XiBFap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:59 INFO - Running setup.py (path:/tmp/pip-a57tuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:59 INFO - Running setup.py (path:/tmp/pip-_ZvVWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:59 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)) 11:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:59 INFO - Running setup.py (path:/tmp/pip-No5d_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:00 INFO - Running setup.py (path:/tmp/pip-hagSd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:00 INFO - Running setup.py (path:/tmp/pip-JOnZFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:00 INFO - Running setup.py (path:/tmp/pip-wYAkmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:00 INFO - Running setup.py (path:/tmp/pip-HCZSjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:00 INFO - Running setup.py (path:/tmp/pip-LyNgv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:00 INFO - Running setup.py (path:/tmp/pip-L82hTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:00 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)) 11:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:00 INFO - Running setup.py (path:/tmp/pip-59RxGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 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)) 11:04:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:04: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 11:04: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 11:04: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 11:04: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 11:04:01 INFO - Downloading blessings-1.6.tar.gz 11:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:04:01 INFO - Installing collected packages: blessings 11:04:01 INFO - Running setup.py install for blessings 11:04:01 INFO - Successfully installed blessings 11:04:01 INFO - Cleaning up... 11:04:01 INFO - Return code: 0 11:04:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:02 INFO - Reading from file tmpfile_stdout 11:04:02 INFO - Current package versions: 11:04:02 INFO - argparse == 1.2.1 11:04:02 INFO - blessings == 1.6 11:04:02 INFO - blobuploader == 1.2.4 11:04:02 INFO - docopt == 0.6.1 11:04:02 INFO - functools32 == 3.2.3-2 11:04:02 INFO - jsonschema == 2.5.1 11:04:02 INFO - manifestparser == 1.1 11:04:02 INFO - mozInstall == 1.13 11:04:02 INFO - mozcrash == 1.0 11:04:02 INFO - mozdebug == 0.1 11:04:02 INFO - mozdevice == 0.51 11:04:02 INFO - mozfile == 1.2 11:04:02 INFO - mozhttpd == 0.7 11:04:02 INFO - mozinfo == 0.10 11:04:02 INFO - mozleak == 0.1 11:04:02 INFO - mozlog == 3.5 11:04:02 INFO - moznetwork == 0.27 11:04:02 INFO - mozprocess == 0.25 11:04:02 INFO - mozprofile == 0.28 11:04:02 INFO - mozrunner == 6.13 11:04:02 INFO - mozscreenshot == 0.1 11:04:02 INFO - mozsystemmonitor == 0.3 11:04:02 INFO - moztest == 0.8 11:04:02 INFO - mozversion == 1.4 11:04:02 INFO - psutil == 3.1.1 11:04:02 INFO - requests == 1.2.3 11:04:02 INFO - wsgiref == 0.1.2 11:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04: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')]} 11:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:02 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:04:02 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 11:04:02 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 11:04:02 INFO - Using env: {'DISPLAY': ':0', 11:04:02 INFO - 'HOME': '/home/cltbld', 11:04:02 INFO - 'LANG': 'en_US.UTF-8', 11:04:02 INFO - 'LANGUAGE': 'en_US:en', 11:04:02 INFO - 'LOGNAME': 'cltbld', 11:04:02 INFO - 'MAIL': '/var/mail/cltbld', 11:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:02 INFO - 'MOZ_NO_REMOTE': '1', 11:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:02 INFO - 'NO_EM_RESTART': '1', 11:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:02 INFO - 'PWD': '/builds/slave/test', 11:04:02 INFO - 'SHELL': '/bin/bash', 11:04:02 INFO - 'SHLVL': '1', 11:04:02 INFO - 'TERM': 'linux', 11:04:02 INFO - 'TMOUT': '86400', 11:04:02 INFO - 'USER': 'cltbld', 11:04:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:02 INFO - '_': '/tools/buildbot/bin/python'} 11:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 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)) 11:04:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:04: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 11:04: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 11:04: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 11:04: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 11:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:04:03 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)) 11:04:03 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)) 11:04:03 INFO - Installing collected packages: simplejson 11:04:03 INFO - Running setup.py install for simplejson 11:04:03 INFO - building 'simplejson._speedups' extension 11:04:03 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 11:04:04 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 11:04:04 INFO - Successfully installed simplejson 11:04:04 INFO - Cleaning up... 11:04:04 INFO - Return code: 0 11:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', '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 11:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:04:04 INFO - Using env: {'DISPLAY': ':0', 11:04:04 INFO - 'HOME': '/home/cltbld', 11:04:04 INFO - 'LANG': 'en_US.UTF-8', 11:04:04 INFO - 'LANGUAGE': 'en_US:en', 11:04:04 INFO - 'LOGNAME': 'cltbld', 11:04:04 INFO - 'MAIL': '/var/mail/cltbld', 11:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:04 INFO - 'MOZ_NO_REMOTE': '1', 11:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:04 INFO - 'NO_EM_RESTART': '1', 11:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:04 INFO - 'PWD': '/builds/slave/test', 11:04:04 INFO - 'SHELL': '/bin/bash', 11:04:04 INFO - 'SHLVL': '1', 11:04:04 INFO - 'TERM': 'linux', 11:04:04 INFO - 'TMOUT': '86400', 11:04:04 INFO - 'USER': 'cltbld', 11:04:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:04 INFO - '_': '/tools/buildbot/bin/python'} 11:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:04:04 INFO - Cleaning up... 11:04:04 INFO - Return code: 0 11:04:04 INFO - Running post-action listener: _resource_record_post_action 11:04:04 INFO - Running post-action listener: _start_resource_monitoring 11:04:04 INFO - Starting resource monitoring. 11:04:04 INFO - [mozharness: 2017-09-08 18:04:04.809042Z] Finished create-virtualenv step (success) 11:04:04 INFO - [mozharness: 2017-09-08 18:04:04.809560Z] Running install step. 11:04:04 INFO - Running pre-action listener: _resource_record_pre_action 11:04:04 INFO - Running main action method: install 11:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:05 INFO - Reading from file tmpfile_stdout 11:04:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:04:05 INFO - Reading from file tmpfile_stdout 11:04:05 INFO - Output received: 11:04:05 INFO - Usage: mozinstall [options] installer 11:04:05 INFO - Options: 11:04:05 INFO - -h, --help show this help message and exit 11:04:05 INFO - -d DEST, --destination=DEST 11:04:05 INFO - Directory to install application into. [default: 11:04:05 INFO - "/builds/slave/test"] 11:04:05 INFO - --app=APP Application being installed. [default: firefox] 11:04:05 INFO - mkdir: /builds/slave/test/build/application 11:04:05 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'] 11:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:04:21 INFO - Reading from file tmpfile_stdout 11:04:21 INFO - Output received: 11:04:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:21 INFO - Running post-action listener: _resource_record_post_action 11:04:21 INFO - [mozharness: 2017-09-08 18:04:21.705712Z] Finished install step (success) 11:04:21 INFO - [mozharness: 2017-09-08 18:04:21.706052Z] Running setup-mitmproxy step. 11:04:21 INFO - Running pre-action listener: _resource_record_pre_action 11:04:21 INFO - Running main action method: setup_mitmproxy 11:04:21 INFO - Skipping: mitmproxy is not required 11:04:21 INFO - Running post-action listener: _resource_record_post_action 11:04:21 INFO - [mozharness: 2017-09-08 18:04:21.707676Z] Finished setup-mitmproxy step (success) 11:04:21 INFO - [mozharness: 2017-09-08 18:04:21.707986Z] Running run-tests step. 11:04:21 INFO - Running pre-action listener: _resource_record_pre_action 11:04:21 INFO - Running pre-action listener: _set_gcov_prefix 11:04:21 INFO - Running main action method: run_tests 11:04:21 WARNING - Try message not found. 11:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:21 INFO - Python 2.7.3 11:04:21 INFO - Return code: 0 11:04:21 INFO - grabbing minidump binary from tooltool 11:04:21 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')]} 11:04:21 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 0x2a3c090>, '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 0x2a3cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:21 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 11:04:21 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 11:04:21 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 11:04:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:21 INFO - Return code: 0 11:04:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:21 INFO - ENV: RUST_BACKTRACE is now full 11:04:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:04:21 INFO - Using env: {'DISPLAY': ':0', 11:04:21 INFO - 'HOME': '/home/cltbld', 11:04:21 INFO - 'LANG': 'en_US.UTF-8', 11:04:21 INFO - 'LANGUAGE': 'en_US:en', 11:04:21 INFO - 'LOGNAME': 'cltbld', 11:04:21 INFO - 'MAIL': '/var/mail/cltbld', 11:04:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:21 INFO - 'MOZ_NO_REMOTE': '1', 11:04:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:21 INFO - 'NO_EM_RESTART': '1', 11:04:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:21 INFO - 'PWD': '/builds/slave/test', 11:04:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:21 INFO - 'RUST_BACKTRACE': 'full', 11:04:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:21 INFO - 'SHELL': '/bin/bash', 11:04:21 INFO - 'SHLVL': '1', 11:04:21 INFO - 'TERM': 'linux', 11:04:21 INFO - 'TMOUT': '86400', 11:04:21 INFO - 'USER': 'cltbld', 11:04:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:21 INFO - '_': '/tools/buildbot/bin/python'} 11:04:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:04:22 INFO - mozversion application_buildid: 20170908171740 11:04:22 INFO - mozversion application_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:22 INFO - mozversion application_display_name: Nightly 11:04:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:22 INFO - mozversion application_name: Firefox 11:04:22 INFO - mozversion application_remotingname: firefox 11:04:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:04:22 INFO - mozversion application_vendor: Mozilla 11:04:22 INFO - mozversion application_version: 57.0a1 11:04:22 INFO - mozversion platform_buildid: 20170908171740 11:04:22 INFO - mozversion platform_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:04:22 INFO - mozversion platform_version: 57.0a1 11:04:22 INFO - using testdate: 1504893862 11:04:22 INFO - actual date: 1504893862 11:04:22 INFO - starting webserver on 'localhost:42285' 11:04:22 INFO - SUITE-START | Running 2 tests 11:04:22 INFO - TEST-START | dromaeo_css 11:04:22 INFO - Initialising browser for dromaeo_css test... 11:04:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html -profile /tmp/tmpcao00h/profile 11:04:22 INFO - TEST-INFO | started process 23803 (/builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html) 11:04:28 INFO - TEST-INFO | 23803: exit 0 11:04:28 INFO - Browser initialized. 11:04:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:28 INFO - Using env: {'DISPLAY': ':0', 11:04:28 INFO - 'HOME': '/home/cltbld', 11:04:28 INFO - 'JSGC_DISABLE_POISONING': '1', 11:04:28 INFO - 'LANG': 'en_US.UTF-8', 11:04:28 INFO - 'LANGUAGE': 'en_US:en', 11:04:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:04:28 INFO - 'LOGNAME': 'cltbld', 11:04:28 INFO - 'MAIL': '/var/mail/cltbld', 11:04:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:28 INFO - 'MOZ_CRASHREPORTER': '1', 11:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:04:28 INFO - 'MOZ_NO_REMOTE': '1', 11:04:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:28 INFO - 'NO_EM_RESTART': '1', 11:04:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:28 INFO - 'PWD': '/builds/slave/test', 11:04:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:28 INFO - 'RUST_BACKTRACE': 'full', 11:04:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:28 INFO - 'SHELL': '/bin/bash', 11:04:28 INFO - 'SHLVL': '1', 11:04:28 INFO - 'STYLO_FORCE_DISABLED': '1', 11:04:28 INFO - 'TERM': 'linux', 11:04:28 INFO - 'TMOUT': '86400', 11:04:28 INFO - 'USER': 'cltbld', 11:04:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:28 INFO - '_': '/tools/buildbot/bin/python'} 11:04:28 INFO - TEST-INFO | started process 24000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcao00h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:29 INFO - PID 24000 | 11:04:29 INFO - PID 24000 | (/builds/slave/test/build/application/firefox/firefox:24051): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:04:29 INFO - PID 24000 | 11:04:39 INFO - PID 24000 | RSS: Main: 167837696 11:04:39 INFO - PID 24000 | 11:07:36 INFO - PID 24000 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42285/tests/dromaeo/cssquery-ext.html) 11:07:37 INFO - PID 24000 | RSS: Main: 171552768 11:07:37 INFO - PID 24000 | 11:10:39 INFO - PID 24000 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-ext.html (next: http://localhost:42285/tests/dromaeo/cssquery-jquery.html) 11:10:40 INFO - PID 24000 | RSS: Main: 167866368 11:10:40 INFO - PID 24000 | 11:13:41 INFO - PID 24000 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42285/tests/dromaeo/cssquery-mootools.html) 11:13:42 INFO - PID 24000 | RSS: Main: 170930176 11:13:42 INFO - PID 24000 | 11:16:44 INFO - PID 24000 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42285/tests/dromaeo/cssquery-prototype.html) 11:16:44 INFO - PID 24000 | RSS: Main: 168878080 11:16:44 INFO - PID 24000 | 11:19:48 INFO - PID 24000 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42285/tests/dromaeo/cssquery-yui.html) 11:19:48 INFO - PID 24000 | RSS: Main: 168591360 11:19:48 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | Cycle 1(1): loaded http://localhost:42285/tests/dromaeo/cssquery-yui.html (next: http://localhost:42285/tests/dromaeo/cssquery-dojo.html) 11:22:50 INFO - PID 24000 | RSS: Main: 172646400 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | __start_tp_report 11:22:50 INFO - PID 24000 | _x_x_mozilla_page_load 11:22:50 INFO - PID 24000 | _x_x_mozilla_page_load_details 11:22:50 INFO - PID 24000 | |i|pagename|runs| 11:22:50 INFO - PID 24000 | |0;dojo.html;3102.1469095998596;3118.0645806258117;3132.185631735748;3135.9529607055883;3149.212696825793;6161.815145545641;6167.907481387771;6248.500119990401;6274.811755647338;6286.497080233582;6253.155823963763;6341.492680585554;6405.42351188393;6487.675616219182;6504;5831.241938548004;5871.031279838843;5924.881502369961;5946.494547963428;5968.31364393096;5830.795922142725;5840.474357307841;5885.234919460486;5956.52347812174;5988.161657367972;5763.1067184586245;5781.831813070099;5804.738786754606;5812.360640329561;5855.4144585541535;5742.339630942453;5787.71061446926;5814;5826.766929322822;5828.03837366834;5616.691081990489;5708;5794.5074668653215;5798.362180160179;5807.30312362515;6234.501239900797;6261.968690156566;6270.6864656766975;6305.243370795488;6317.684115794192;6648.202215734094;6655.035019922133;6664.966675166593;6731.0913026741255;6897.448204143657;6814.046033555306;6871.175458944908;6894.379505844498;6908.447324214101;6913.654317284116;6160.815175544696;6211.534134939852;6277.278113016971;6290.308066112724;6377.362263773585;6934.895976560356;6958.617276049765;7051.294870512907;7081.433485321162;7115.92884071163;6626.83432914181;6683.030960510699;6710.261871194165;6716.798496045127;6723.5293529452465;6678.098456708282;6775.390214880685;6785.59286442815;6860.211075726355;6863.759768408082;6624.90062649051;6688.86622267552;6726;6731.427828634621;6808.9659551701925;6663.06717059612;6816.318368163144;6819.5908245505425;6844.178698556205;6849.760258390932;5209.192575150858;5274.26160337553;5338.813141540028;5351.25082488452;5361.169018802092;4540;4617;4629.259318509023;4650.767461626905;4663.860084197411;5667.546596272288;5670.716464176857;5748.511376533042;5813.709314534256;5824.708764561755;6798.66006699663;6872.931270687329;6898.344657257552;6900.654967251618;6909.032735417046;5760.539156867524;5778.479936805707;5793.24687790593;5813.709314534256;5840.3575606683235;5714.828555143353;5778.711064446761;5803.158542011469;5825.825225243249;5874.9118763218585;6486.837829054311;6563.704633291513;6570.540062195696;6575.079488871562;6580.967095164589;6734.124563806772;6735.2927942567285;6823.624700641512;6841.657917104125;6852.5203235773015;6316.305206427198;6461.741530338733;6471.676416179266;6476.773312934025;6551.80344589663;6584.407403333723;6593.439557637655;6596.439302659328;6600.438962688226;6672.666366681549;6870;6878.209005964378;6881.13985751781;6881.174259088942;6882.105326307548;6400.103985441949;6549.083128361938;6555.2789193189665;6559.147310849559;6620.801375958729;6571;6633.005049242653;6650.83372915681;6654.83362915931;6655.800325990228;6366.045093236052;6519.282878883414;6522.641254731036;6584.209894812653;6610.074589557562;6559.836004099936;6597.868042639025;6610.702518386588;6645.700943457459;6703.530752847254;6309.274433440213;6367.299597044229;6407.967960160169;6438.67806609677;6461 11:22:50 INFO - PID 24000 | |1;ext.html;850.3154960256993;873.423540463294;875.1598465473147;875.7635438431623;880.4585180114232;38693.80653096734;42260.57739422605;42276.57723422765;42294;42368.576314236845;38934.8053259734;39225.21549569014;39236.21527569447;39308.60691393085;39313.21373572534;7105.822354441155;7217.13394392671;7219.386352160072;7221.241769614194;7806.414518911076;7826.09999850016;7918.168592297812;7920.920790792076;7922.762317130495;7925.801854953615;7897.210278972114;7984.520928744294;7986.201379861996;7989.161138080505;7989.800254993614;7765.456418050739;7996.08045074818;7996.880046799302;8000.039995200584;8002.839943201104;7800.726974555863;7865.292123708837;7878.409119316017;7878.842423151505;7882.7241046563095;36993.81503092494;37066.44400333997;37081.81459092714;37179.62820371789;37190.81404592987;3572.0534058474527;3601.045722883438;3608.9639103608893;3612.548431446069;3612.747107702462;30557.847210764026;30623;30660.846695766602;30721.231969200726;30737;5229.137192363255;5254.21186821976;5256.81601143962;5285.68285902847;5364;184244.15755842405;184598;184659;184726;185689;47717.761411192725;47828.28257576139;47870.28194577084;49939.25091123636;50950.74524627353;52174;52222;52426.737866310425;52559.73720131375;52604;14215.218163001135;14450.710985780226;14466.132032078109;16423.260953257133;16651.916740416462;11624.244424112405;11635.709107272385;11733.4133293335;11744.236624619372;11746.471408786625;12954.287514186623;13074.869251307555;13077.607671769862;13083.934580327228;13123;5799.39106393831;5818.050952930816;5898.852528686817;5920.289565252111;5928.584999050025;980.152168374351;994.6021591363512;998.1266391907081;1013.1337706261188;1021.3310281765456;21933.670994935088;22079.33761987143;22113.115475380804;22219.66670499944;22396.55206895853;1097.286763603648;1102.7077824376547;1103.0734183286079;1103.508938522366;1122.7586068995206;11813.88186118145;11819.409029548488;11824.70438239051;11868.940655296668;11894.82157767634;220023;220823;221566;222135;222542;52204.47795522072;52601.684957875594;52653.736731316865;52717.736411317695;52798.20802687963;1417.9007469477037;1431.2986636548226;1432.7277817214697;1435.382785402287;1438.8633079857398;22929.88535057314;26726.866365668047;27099.458010840066;27330.04344847921;27439.314017148932;49191.754041229564;49297;49363.25955110748;49380.50619493903;49460.50539494703;190854;191918;191976;192623;193230;34380.48429273513;34773.13067173341;34825.82587087048;35256.64743352534;35262.647373525935;42041.57958420377;43055.1388972225;43138.921526962076;43546.34680479859;43558.34662480002;30245.243868903453;30593.54109688401;30641.927532536254;30924.845375772977;31237.375252495276;31035.84482077575;31102.53346199854;31427.68572314339;31653.20866978344;31938.36123277475;35284.47073293851;35312;35527;35571.64428355683;35605.64394356023;30221.69778302189;30570.235744106576;30624.234394140323;30681.8465907669;30700.385992279582;22658.886705566365;22964;23030.42423939348;23099.3070207894;23486.530269394174 11:22:50 INFO - PID 24000 | |2;jquery.html;556.3879732294477;568.6303902463401;571.2973043156919;572.8424683212116;576.9278840144982;22076.88961555192;22920.083196672113;22936.54126917465;22941.885290573566;22965.081396744154;23086.191983280587;24012.159574414898;24042.87978560109;24318.75681243187;24319.878400608017;6608.735650573972;6739.764108256212;6749.93250067498;6752;6756.864862702743;6268.968655156741;6639.33606639337;6707.899381509281;6742.865142697143;6745.595264284134;6461.612303261796;6515.837104072389;6516.9674151629415;6522.510811689119;6525.216973963131;6511.674416279167;6521.869562608745;6523.119378883885;6526.445252153572;6527.216733991928;5952.672603006833;6068.6358818471035;6164.229471316085;6177.62934223948;6185;28197.57703634447;28654.283642908886;28669.713302867123;28690;28692;2083.083443284965;2098.0768461876723;2110.915563377463;2111.8944052797297;2113.9788602113936;18781.81218187828;19161.61676766471;19585.314513992085;19589.608207835765;19772.11025503856;2396.388920825196;2404.9639255411184;2429.829911906167;2436.9634455483183;2442.9755702443103;118022.40988795001;123744.38127809393;124832;130179.34910325482;130393;14149.29253537319;14181.149131051963;14404.711905761826;14444.350004249834;14567.490137845125;22194.556108877732;22194.88902555477;22223.555528889654;22226.888865555567;22229.221977230718;10010.799784004279;10174.135198508062;10235.44522687397;10286.485675716185;10296.639617613348;9531.426514840954;9560;9567.808643827224;9622.278329125204;9632.422054676741;8742.388032837767;8893.599788009555;8935.463872167691;8966.282697384193;8975.37172397939;2621.659184306028;2678.491086693522;2720.8503532305913;2772.4177922636068;2858.1854171561004;925.8564922437033;961.0581630002497;963.8843338799389;968.9806203876024;972.9464879431699;18339.659812842274;18733.531661708566;18839.71740423895;18866;19172.80827191738;1017.0947856407803;1021.4586269277146;1021.4994652620163;1026.9897301026895;1036.0778906772978;10110.006547413877;10416.843747343795;10425.530851111718;10444.112250458644;10543.578256869792;440016;441032;448677;455684;463512.04731929046;105382.47308763408;106677.46661266644;106902.46548767206;108086;110382;1138.1748232531513;1169.7017260598664;1173.4191575170346;1173.6303064534645;1183.7336599265268;16677.833221668112;16869.578260543585;16983.83016169872;17152;17360.652786944444;52350.73824630852;53208;53245.733771330895;54084;54177.729111354194;62356.376436235056;62437;62646.06030909631;64540.6772966151;66245.33754662392;13427.26150061756;13846.10000349974;13909.652258693613;13909.860901390857;13947.232902190477;21347.893260533598;21569.460763480412;21645.13419463204;21705.457363566038;21720.565588687823;17086.57283567871;17091.145442728062;17461.47615571535;17480.47558573245;17534.123293835;15354.539363819104;15563.299651515936;15590.220488975732;16213.837861621232;16262.024278543326;16969.490915272563;17272.481825545256;17555.912220438815;17569;17780.644387111926;13657.317134143055;13678.452861885413;13801.171929684251;13802.723945520833;13843.861561384258;17238.913805430893;17247.051412172452;17250;17359;17388.13059347053 11:22:50 INFO - PID 24000 | |3;mootools.html;1342.6307765364525;1381.5440904501515;1392.867677570631;1397.4410235905636;1404.269779714548;14988.625284367883;15567.065976041431;15610.84389156108;15611.531654050368;15649.295781689823;15123.092614443114;15186.240687965612;15210.771838422432;15252.084874907485;15253.771193432107;2774.140016594852;2848.4872722909868;2851.6863145054026;2860.542313229884;2860.9557511508256;2711.5932610108443;2794.9161525154277;2870.540713485843;2874.0946601820465;2876.6691830439454;2784.554471284595;2829.236106251311;2839.9716002839914;2840.573913912909;2841.3891013432108;2628.7371262873753;2653.283613424365;2655.1768951624963;2655.880485378153;2658.069675613539;2606.1399738086575;2608.699999500063;2611.347163209198;2615.320016795628;2630.145202809095;14884.851151488454;14972.550823475205;15315.234238288042;15320.23398830054;15340.156291403968;7919.089304729914;8238.464499807553;8242.340612751026;8243.505389676639;8246.257836794657;5198.454162312978;5288.603354748409;5327.094393953037;5406.189071639285;5516.779328826842;1837.9632407351778;1838.8253115953962;1882.6705326567796;1890.3194849854042;1899.8005209453086;26017.219483415527;26341.473170536483;26456.338591535172;26458.735412646012;26496.602550961557;7016.684249208798;7343.77968660941;7411.221821708643;7678.347340476011;7743;17178.570535736457;17286.913565432093;17321.65356692859;17356.82643173552;17370.652586948192;7644.388448924073;7725.5364678119495;7750.186230445835;7767.02912135983;7788.610569471503;7039.683214255371;7126.964365178244;7162.534435261691;7389.66746496409;7482.438817088631;5190.455002224712;5265.578753699695;5289.920651190235;5322.148456246982;5337.866553336197;1553.3941762712552;1584.382090984517;1593.3148746039083;1595.6649103688123;1612.2825342722376;874.152072489684;887.0331338840566;888.7822483491586;903.5301643145659;905.538175530471;7674.8081297968;7690.73082442123;7696.769096927102;7708.730194443167;7711.228877112244;697.6128248821952;717.078554058033;725.0755287009106;726.4551586310267;727.8944553039779;5357.973210133924;5515.531179849678;5566.053770858964;5607.579431542651;5678.5741069419955;20683.172673092908;21049.89475052615;21426.142954281964;21622.567548648938;21692.24077157292;20792.792072079388;21802.236921707983;21962.231321903655;21972.560548788933;22141.557168856532;11081.335119892832;11591.014763745008;11599.88400116005;11632.185746997799;11636.825447618292;6983.825404364931;9058.682946096855;9135.40619859707;9145.862812057958;9186.40288381253;17883.73174402411;18259;18332.816671833112;18341;18348.633027339645;19128.139233734237;19206.7118993218;19219.903900480407;19284.71072933879;19779.307724229584;9950;10145.797084058426;10157.035081667525;10161.288709790244;10164.644237451654;13539.729205416033;13678.452861885413;13736;13850.09974351664;13857;11177.944110279723;11448;11571.074314054687;11627;11650.53397864076;10848.728781780519;11114.722131946766;11220.551177953117;11365.374904380007;11394.601188958346;9657.082577155159;9760.365576237522;9846.556904939438;9851.605935762489;9851.802963940825;6938.618375989167;6942.826429339105;6980.755673551402;6982;7034.331738484836;7119.323664252095;7126.714931402686;7174.282571742784;7198.100237470317;7253 11:22:50 INFO - PID 24000 | |4;prototype.html;498.36039430274377;505.0703948016147;513.0764623677381;522.4253321346522;531.8989691338927;6281.748730050798;6352.745890164394;6411.166548348714;6423.903641445382;6433.008650977295;6229.290258737452;6239.8128056158275;6256.374362563742;6330.208723909512;6346.6826658667;5265.447128051538;5281.9207711884355;5324.813631522898;5336.412994570614;5356.143017117262;5071.416787069479;5240.34495688039;5327.600429967768;5349.421920533433;5355.223492593591;5274.472552744734;5285.127953887604;5288.894222115556;5295.4704529547125;5328.573714102882;5199.428062913076;5220.973895130538;5232.7964568149155;5256.894862102775;5297.867553311159;4855.150348688965;4872.806162490213;4934.753262336869;4935.506449355072;4941.1847045237855;6277.089821975788;6307.653079080649;6325.367463253684;6346.714397852108;6355.332690067568;5951.5238780897425;5960.850978725523;6013.609115407528;6057.666828324441;6083.939160608382;6547.869042619121;6626.7017984190825;6649.5012874034155;6698.526324208667;6722.327767223287;5256.842294731164;5263.842084737464;5317.867053323659;5333.839984800462;5358.678479291255;6871.14110736163;6958.304169583052;6971.686274117626;6975.651217439209;6985.406240469566;5345.305110335709;5393.191021346751;5396.271503347077;5474.808381706621;5489.478499542537;5571.804986825523;5577.2191893135;5656.462636049569;5668.376478587352;5674.546036317085;6027.558838670346;6028.939710602838;6067.302260240041;6069.241344831896;6082.60463069899;6392.3927226913365;6762.546052598715;6775;6775.661216939232;6778.864422711518;1868.6262747450564;1886.5660897993264;1909.8376637985648;1952.4728323352615;1966.2233417800176;1448.4640682947377;1452.9418823246951;1461.4497701510932;1472.1314424489603;1478.911265324084;5712.942870571324;5772.460117548266;5777;5778.913316300259;5799.681017543991;6622.9006564901565;6775.1869775626255;6814.5467631653555;6824.590524568443;6872.518923675295;5753.050746626844;5801.445864995958;5805.82582522525;5808.970955145282;5818.8761102197395;3572.3391172633146;3621.0042238384126;3629.546306711661;3640.8361623726464;3645.5260816093737;6500.252470965899;6550.213974323112;6551.772397384912;6565.883799754053;6624.370684785034;6921.6193109379465;6931.549449285781;6943.79168624942;6967.616781076988;6986.825329366807;6506.186726659168;6523.3150519194805;6530.902036469457;6535.640539770168;6536.24833144185;6792.66036698173;6810.659467026728;6840;6845.965770171118;6847.589144651337;6750.392464678006;6764.289749576224;6784.728610855708;6812.761553345609;6815.454763618799;6350.7777227796805;6435.292117866938;6480.837979050561;6482.837929051623;6521.804345869631;4975.875603109951;4979.701217926936;5013.623978201576;5046.621503387188;5047.350141175765;6603.834904127435;6725.293844146294;6823.078884350549;6859.862802744017;6884.93115068863;6311.431971122621;6502.479801615765;6568.343165683394;6575.934240657532;6612.355057976848;6495.188101487314;6528.281888992112;6589.868202636017;6604.438622717123;6635.867282654416;6332.335104814112;6393.392627700361;6412.6793660317735;6536.869262614816;6561.670606934469;6554.180727409074;6581.473482121323;6630.3038180992235;6650.672264707314;6664.466842652673;6299.055141728777;6333.683315834282;6410.551261411656;6425.485961123192;6431.549791514549 11:22:50 INFO - PID 24000 | |5;yui.html;901.1664210605189;904.0823564082461;915.4964769376845;919.5632074764487;930.6417029443664;19919.302824401148;19964.50088747782;20332.390028299156;20457.386278411635;20461.99999999998;19183.616327673437;19413.417597472064;19479.220831166735;19491.122899469523;19528.70706939397;939.8543225800012;952.9714108576753;953.1945506047414;955.4506158958592;955.8709574207497;944.9338546301761;966.893641699416;975.5805003848342;985.7683444390562;986.9358491698017;1025.5692609104158;1025.7692019295673;1028.5731421460084;1030.1295405382477;1030.1912998296339;965.1651321606795;1001.5042553935775;1004.6634377483551;1005.2762011351815;1018.801333739921;738.3797610007566;742.3801126059747;744.2111361956344;744.5941961630924;744.8361360500735;17976.19107140169;18176.818231817644;18204.089795510172;18206.271749130017;18233.088345582666;21499.785002149936;22319.218827341127;22381.328560143058;22396;22417.887910560505;16480.084610472575;16736.916315418344;16746.330146794236;16750.497485075466;16791.748123778154;3419.093940105849;3467.098554375855;3469.2194256292387;3470.7570470067108;3471.3057388522398;140470;143065;144118.55881441158;144195.2790236042;147391.26304368518;16210.43263485796;16491.6701665966;16674.249658765384;16724.41464548759;16733.66532669364;27584.172474825387;28891.711082889324;29048.7095129046;29092.127236182947;29147.85426072856;8112.1887811219585;8115.1073381927945;8170.959145204236;8203.876941845878;8225.424220304521;3933.5083114610675;4023.436718859362;4048.4939382577177;4049.5950404959267;4067.7152599317765;5337.759800808973;5441.374241962146;5452.863678407992;5469.699166545799;5472.945270547323;931.9207867331353;947.5309721687809;955.3551352836807;960.6349587156835;972.6255391674256;686.8111269400955;699.2168770976539;708.3553965891015;713.0587624335827;721.4476652323854;10857.131429485622;11548.364839933884;11616.282789507446;12569.371531423392;12606.55877044299;671.3521451799037;671.375620672779;677.2448719677623;695.6486974078058;703.057902410772;5282.973585132127;5314.335708036496;5471.671699698031;5483.862903427446;5516.034693928546;119694;121709;121993.34019979415;122301;126100.36949815192;105964;106207;107973.46013269883;109557;110734.44632776784;94715.52642236883;96161;98540;100016.99983000223;100673;9956.900430995598;10048.447335396624;10169.84745228837;10219.233557483367;10337.37975721459;44095;45144;45605.54394456013;45710.77144614256;45727;58271.417285826596;58769.70615146897;59695.40304596898;60046;61560.69219653873;15072.321745521696;15594.688106238038;15626;15626.687466250383;15723.371065157266;17022.14889255557;17052.74420883663;17139.228734706718;17300.913495432444;17304.13479326054;14006;14065.648358791112;14079.436822526985;14345.282735863373;14370.85629143737;15278.770818437955;15476.380944762084;15552.222388880737;15609.765853511979;15731.764023539426;14487.855121449073;14691.926540367229;14715.779263311273;14832.925835370754;14854.183019933575;11016.614418495314;11089.944550277198;11181.552737890719;11239.60661376848;11277.097832173242;10850.945745271223;10997.670069897917;11001.889981100407;11096.167787415814;11261.549538018387 11:22:50 INFO - PID 24000 | __end_tp_report 11:22:50 INFO - PID 24000 | __start_cc_report 11:22:50 INFO - PID 24000 | _x_x_mozilla_cycle_collect,342 11:22:50 INFO - PID 24000 | __end_cc_report 11:22:50 INFO - PID 24000 | __startTimestamp1504894970595__endTimestamp 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | ------- Summary: start ------- 11:22:50 INFO - PID 24000 | Number of tests: 6 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | [#0] dojo.html Cycles:165 Average:6219.14 Median:6471.68 stddev:761.07 (11.8%) stddev-sans-first:723.06 11:22:50 INFO - PID 24000 | Values: 3102.1 3118.1 3132.2 3136.0 3149.2 6161.8 6167.9 6248.5 6274.8 6286.5 6253.2 6341.5 6405.4 6487.7 6504.0 5831.2 5871.0 5924.9 5946.5 5968.3 5830.8 5840.5 5885.2 5956.5 5988.2 5763.1 5781.8 5804.7 5812.4 5855.4 5742.3 5787.7 5814.0 5826.8 5828.0 5616.7 5708.0 5794.5 5798.4 5807.3 6234.5 6262.0 6270.7 6305.2 6317.7 6648.2 6655.0 6665.0 6731.1 6897.4 6814.0 6871.2 6894.4 6908.4 6913.7 6160.8 6211.5 6277.3 6290.3 6377.4 6934.9 6958.6 7051.3 7081.4 7115.9 6626.8 6683.0 6710.3 6716.8 6723.5 6678.1 6775.4 6785.6 6860.2 6863.8 6624.9 6688.9 6726.0 6731.4 6809.0 6663.1 6816.3 6819.6 6844.2 6849.8 5209.2 5274.3 5338.8 5351.3 5361.2 4540.0 4617.0 4629.3 4650.8 4663.9 5667.5 5670.7 5748.5 5813.7 5824.7 6798.7 6872.9 6898.3 6900.7 6909.0 5760.5 5778.5 5793.2 5813.7 5840.4 5714.8 5778.7 5803.2 5825.8 5874.9 6486.8 6563.7 6570.5 6575.1 6581.0 6734.1 6735.3 6823.6 6841.7 6852.5 6316.3 6461.7 6471.7 6476.8 6551.8 6584.4 6593.4 6596.4 6600.4 6672.7 6870.0 6878.2 6881.1 6881.2 6882.1 6400.1 6549.1 6555.3 6559.1 6620.8 6571.0 6633.0 6650.8 6654.8 6655.8 6366.0 6519.3 6522.6 6584.2 6610.1 6559.8 6597.9 6610.7 6645.7 6703.5 6309.3 6367.3 6408.0 6438.7 6461.0 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | [#1] ext.html Cycles:180 Average:37158.74 Median:35588.64 stddev:51857.77 (145.7%) stddev-sans-first:51931.58 11:22:50 INFO - PID 24000 | Values: 850.3 873.4 875.2 875.8 880.5 38693.8 42260.6 42276.6 42294.0 42368.6 38934.8 39225.2 39236.2 39308.6 39313.2 7105.8 7217.1 7219.4 7221.2 7806.4 7826.1 7918.2 7920.9 7922.8 7925.8 7897.2 7984.5 7986.2 7989.2 7989.8 7765.5 7996.1 7996.9 8000.0 8002.8 7800.7 7865.3 7878.4 7878.8 7882.7 36993.8 37066.4 37081.8 37179.6 37190.8 3572.1 3601.0 3609.0 3612.5 3612.7 30557.8 30623.0 30660.8 30721.2 30737.0 5229.1 5254.2 5256.8 5285.7 5364.0 184244.2 184598.0 184659.0 184726.0 185689.0 47717.8 47828.3 47870.3 49939.3 50950.7 52174.0 52222.0 52426.7 52559.7 52604.0 14215.2 14450.7 14466.1 16423.3 16651.9 11624.2 11635.7 11733.4 11744.2 11746.5 12954.3 13074.9 13077.6 13083.9 13123.0 5799.4 5818.1 5898.9 5920.3 5928.6 980.2 994.6 998.1 1013.1 1021.3 21933.7 22079.3 22113.1 22219.7 22396.6 1097.3 1102.7 1103.1 1103.5 1122.8 11813.9 11819.4 11824.7 11868.9 11894.8 220023.0 220823.0 221566.0 222135.0 222542.0 52204.5 52601.7 52653.7 52717.7 52798.2 1417.9 1431.3 1432.7 1435.4 1438.9 22929.9 26726.9 27099.5 27330.0 27439.3 49191.8 49297.0 49363.3 49380.5 49460.5 190854.0 191918.0 191976.0 192623.0 193230.0 34380.5 34773.1 34825.8 35256.6 35262.6 42041.6 43055.1 43138.9 43546.3 43558.3 30245.2 30593.5 30641.9 30924.8 31237.4 31035.8 31102.5 31427.7 31653.2 31938.4 35284.5 35312.0 35527.0 35571.6 35605.6 30221.7 30570.2 30624.2 30681.8 30700.4 22658.9 22964.0 23030.4 23099.3 23486.5 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | [#2] jquery.html Cycles:180 Average:32398.81 Median:22135.72 stddev:75682.42 (341.9%) stddev-sans-first:75856.96 11:22:50 INFO - PID 24000 | Values: 556.4 568.6 571.3 572.8 576.9 22076.9 22920.1 22936.5 22941.9 22965.1 23086.2 24012.2 24042.9 24318.8 24319.9 6608.7 6739.8 6749.9 6752.0 6756.9 6269.0 6639.3 6707.9 6742.9 6745.6 6461.6 6515.8 6517.0 6522.5 6525.2 6511.7 6521.9 6523.1 6526.4 6527.2 5952.7 6068.6 6164.2 6177.6 6185.0 28197.6 28654.3 28669.7 28690.0 28692.0 2083.1 2098.1 2110.9 2111.9 2114.0 18781.8 19161.6 19585.3 19589.6 19772.1 2396.4 2405.0 2429.8 2437.0 2443.0 118022.4 123744.4 124832.0 130179.3 130393.0 14149.3 14181.1 14404.7 14444.4 14567.5 22194.6 22194.9 22223.6 22226.9 22229.2 10010.8 10174.1 10235.4 10286.5 10296.6 9531.4 9560.0 9567.8 9622.3 9632.4 8742.4 8893.6 8935.5 8966.3 8975.4 2621.7 2678.5 2720.9 2772.4 2858.2 925.9 961.1 963.9 969.0 972.9 18339.7 18733.5 18839.7 18866.0 19172.8 1017.1 1021.5 1021.5 1027.0 1036.1 10110.0 10416.8 10425.5 10444.1 10543.6 440016.0 441032.0 448677.0 455684.0 463512.0 105382.5 106677.5 106902.5 108086.0 110382.0 1138.2 1169.7 1173.4 1173.6 1183.7 16677.8 16869.6 16983.8 17152.0 17360.7 52350.7 53208.0 53245.7 54084.0 54177.7 62356.4 62437.0 62646.1 64540.7 66245.3 13427.3 13846.1 13909.7 13909.9 13947.2 21347.9 21569.5 21645.1 21705.5 21720.6 17086.6 17091.1 17461.5 17480.5 17534.1 15354.5 15563.3 15590.2 16213.8 16262.0 16969.5 17272.5 17555.9 17569.0 17780.6 13657.3 13678.5 13801.2 13802.7 13843.9 17238.9 17247.1 17250.0 17359.0 17388.1 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | [#3] mootools.html Cycles:180 Average:9318.23 Median:2654.23 stddev:6649.52 (250.5%) stddev-sans-first:6641.17 11:22:50 INFO - PID 24000 | Values: 1342.6 1381.5 1392.9 1397.4 1404.3 14988.6 15567.1 15610.8 15611.5 15649.3 15123.1 15186.2 15210.8 15252.1 15253.8 2774.1 2848.5 2851.7 2860.5 2861.0 2711.6 2794.9 2870.5 2874.1 2876.7 2784.6 2829.2 2840.0 2840.6 2841.4 2628.7 2653.3 2655.2 2655.9 2658.1 2606.1 2608.7 2611.3 2615.3 2630.1 14884.9 14972.6 15315.2 15320.2 15340.2 7919.1 8238.5 8242.3 8243.5 8246.3 5198.5 5288.6 5327.1 5406.2 5516.8 1838.0 1838.8 1882.7 1890.3 1899.8 26017.2 26341.5 26456.3 26458.7 26496.6 7016.7 7343.8 7411.2 7678.3 7743.0 17178.6 17286.9 17321.7 17356.8 17370.7 7644.4 7725.5 7750.2 7767.0 7788.6 7039.7 7127.0 7162.5 7389.7 7482.4 5190.5 5265.6 5289.9 5322.1 5337.9 1553.4 1584.4 1593.3 1595.7 1612.3 874.2 887.0 888.8 903.5 905.5 7674.8 7690.7 7696.8 7708.7 7711.2 697.6 717.1 725.1 726.5 727.9 5358.0 5515.5 5566.1 5607.6 5678.6 20683.2 21049.9 21426.1 21622.6 21692.2 20792.8 21802.2 21962.2 21972.6 22141.6 11081.3 11591.0 11599.9 11632.2 11636.8 6983.8 9058.7 9135.4 9145.9 9186.4 17883.7 18259.0 18332.8 18341.0 18348.6 19128.1 19206.7 19219.9 19284.7 19779.3 9950.0 10145.8 10157.0 10161.3 10164.6 13539.7 13678.5 13736.0 13850.1 13857.0 11177.9 11448.0 11571.1 11627.0 11650.5 10848.7 11114.7 11220.6 11365.4 11394.6 9657.1 9760.4 9846.6 9851.6 9851.8 6938.6 6942.8 6980.8 6982.0 7034.3 7119.3 7126.7 7174.3 7198.1 7253.0 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | [#4] prototype.html Cycles:180 Average:5667.17 Median:6303.35 stddev:1514.48 (24.0%) stddev-sans-first:1468.20 11:22:50 INFO - PID 24000 | Values: 498.4 505.1 513.1 522.4 531.9 6281.7 6352.7 6411.2 6423.9 6433.0 6229.3 6239.8 6256.4 6330.2 6346.7 5265.4 5281.9 5324.8 5336.4 5356.1 5071.4 5240.3 5327.6 5349.4 5355.2 5274.5 5285.1 5288.9 5295.5 5328.6 5199.4 5221.0 5232.8 5256.9 5297.9 4855.2 4872.8 4934.8 4935.5 4941.2 6277.1 6307.7 6325.4 6346.7 6355.3 5951.5 5960.9 6013.6 6057.7 6083.9 6547.9 6626.7 6649.5 6698.5 6722.3 5256.8 5263.8 5317.9 5333.8 5358.7 6871.1 6958.3 6971.7 6975.7 6985.4 5345.3 5393.2 5396.3 5474.8 5489.5 5571.8 5577.2 5656.5 5668.4 5674.5 6027.6 6028.9 6067.3 6069.2 6082.6 6392.4 6762.5 6775.0 6775.7 6778.9 1868.6 1886.6 1909.8 1952.5 1966.2 1448.5 1452.9 1461.4 1472.1 1478.9 5712.9 5772.5 5777.0 5778.9 5799.7 6622.9 6775.2 6814.5 6824.6 6872.5 5753.1 5801.4 5805.8 5809.0 5818.9 3572.3 3621.0 3629.5 3640.8 3645.5 6500.3 6550.2 6551.8 6565.9 6624.4 6921.6 6931.5 6943.8 6967.6 6986.8 6506.2 6523.3 6530.9 6535.6 6536.2 6792.7 6810.7 6840.0 6846.0 6847.6 6750.4 6764.3 6784.7 6812.8 6815.5 6350.8 6435.3 6480.8 6482.8 6521.8 4975.9 4979.7 5013.6 5046.6 5047.4 6603.8 6725.3 6823.1 6859.9 6884.9 6311.4 6502.5 6568.3 6575.9 6612.4 6495.2 6528.3 6589.9 6604.4 6635.9 6332.3 6393.4 6412.7 6536.9 6561.7 6554.2 6581.5 6630.3 6650.7 6664.5 6299.1 6333.7 6410.6 6425.5 6431.5 11:22:50 INFO - PID 24000 | 11:22:50 INFO - PID 24000 | [#5] yui.html Cycles:180 Average:24306.12 Median:19941.90 stddev:35904.12 (180.0%) stddev-sans-first:35961.83 11:22:50 INFO - PID 24000 | Values: 901.2 904.1 915.5 919.6 930.6 19919.3 19964.5 20332.4 20457.4 20462.0 19183.6 19413.4 19479.2 19491.1 19528.7 939.9 953.0 953.2 955.5 955.9 944.9 966.9 975.6 985.8 986.9 1025.6 1025.8 1028.6 1030.1 1030.2 965.2 1001.5 1004.7 1005.3 1018.8 738.4 742.4 744.2 744.6 744.8 17976.2 18176.8 18204.1 18206.3 18233.1 21499.8 22319.2 22381.3 22396.0 22417.9 16480.1 16736.9 16746.3 16750.5 16791.7 3419.1 3467.1 3469.2 3470.8 3471.3 140470.0 143065.0 144118.6 144195.3 147391.3 16210.4 16491.7 16674.2 16724.4 16733.7 27584.2 28891.7 29048.7 29092.1 29147.9 8112.2 8115.1 8171.0 8203.9 8225.4 3933.5 4023.4 4048.5 4049.6 4067.7 5337.8 5441.4 5452.9 5469.7 5472.9 931.9 947.5 955.4 960.6 972.6 686.8 699.2 708.4 713.1 721.4 10857.1 11548.4 11616.3 12569.4 12606.6 671.4 671.4 677.2 695.6 703.1 5283.0 5314.3 5471.7 5483.9 5516.0 119694.0 121709.0 121993.3 122301.0 126100.4 105964.0 106207.0 107973.5 109557.0 110734.4 94715.5 96161.0 98540.0 100017.0 100673.0 9956.9 10048.4 10169.8 10219.2 10337.4 44095.0 45144.0 45605.5 45710.8 45727.0 58271.4 58769.7 59695.4 60046.0 61560.7 15072.3 15594.7 15626.0 15626.7 15723.4 17022.1 17052.7 17139.2 17300.9 17304.1 14006.0 14065.6 14079.4 14345.3 14370.9 15278.8 15476.4 15552.2 15609.8 15731.8 14487.9 14691.9 14715.8 14832.9 14854.2 11016.6 11089.9 11181.6 11239.6 11277.1 10850.9 10997.7 11001.9 11096.2 11261.5 11:22:50 INFO - PID 24000 | -------- Summary: end -------- 11:22:50 INFO - PID 24000 | 11:22:51 INFO - TEST-INFO | 24000: exit 0 11:22:51 INFO - TEST-OK | dromaeo_css | took 1109245ms 11:22:51 INFO - TEST-START | kraken 11:22:51 INFO - Initialising browser for kraken test... 11:22:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html -profile /tmp/tmpRimYd8/profile 11:22:51 INFO - TEST-INFO | started process 24372 (/builds/slave/test/build/application/firefox/firefox http://localhost:42285/getInfo.html) 11:22:56 INFO - TEST-INFO | 24372: exit 0 11:22:56 INFO - Browser initialized. 11:22:56 INFO - Running cycle 1/1 for kraken test... 11:22:56 INFO - Using env: {'DISPLAY': ':0', 11:22:56 INFO - 'HOME': '/home/cltbld', 11:22:56 INFO - 'JSGC_DISABLE_POISONING': '1', 11:22:56 INFO - 'LANG': 'en_US.UTF-8', 11:22:56 INFO - 'LANGUAGE': 'en_US:en', 11:22:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:22:56 INFO - 'LOGNAME': 'cltbld', 11:22:56 INFO - 'MAIL': '/var/mail/cltbld', 11:22:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:56 INFO - 'MOZ_CRASHREPORTER': '1', 11:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:22:56 INFO - 'MOZ_NO_REMOTE': '1', 11:22:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:56 INFO - 'NO_EM_RESTART': '1', 11:22:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:56 INFO - 'PWD': '/builds/slave/test', 11:22:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:56 INFO - 'RUST_BACKTRACE': 'full', 11:22:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:56 INFO - 'SHELL': '/bin/bash', 11:22:56 INFO - 'SHLVL': '1', 11:22:56 INFO - 'STYLO_FORCE_DISABLED': '1', 11:22:56 INFO - 'TERM': 'linux', 11:22:56 INFO - 'TMOUT': '86400', 11:22:56 INFO - 'USER': 'cltbld', 11:22:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274', 11:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:56 INFO - '_': '/tools/buildbot/bin/python'} 11:22:56 INFO - TEST-INFO | started process 24565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRimYd8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:57 INFO - PID 24565 | 11:22:57 INFO - PID 24565 | (/builds/slave/test/build/application/firefox/firefox:24616): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:57 INFO - PID 24565 | 11:23:07 INFO - PID 24565 | RSS: Main: 170184704 11:23:07 INFO - PID 24565 | 11:23:10 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-beat-detection) 11:23:11 INFO - PID 24565 | RSS: Main: 176091136 11:23:11 INFO - PID 24565 | 11:23:14 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-dft) 11:23:14 INFO - PID 24565 | RSS: Main: 176775168 11:23:14 INFO - PID 24565 | 11:23:17 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-fft) 11:23:18 INFO - PID 24565 | RSS: Main: 170704896 11:23:18 INFO - PID 24565 | 11:23:20 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42285/tests/kraken/driver.html?testName=audio-oscillator) 11:23:20 INFO - PID 24565 | RSS: Main: 172343296 11:23:20 INFO - PID 24565 | 11:23:22 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:23 INFO - PID 24565 | RSS: Main: 172969984 11:23:23 INFO - PID 24565 | 11:23:26 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42285/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:27 INFO - PID 24565 | RSS: Main: 175833088 11:23:27 INFO - PID 24565 | 11:23:30 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42285/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:31 INFO - PID 24565 | RSS: Main: 174735360 11:23:31 INFO - PID 24565 | 11:23:34 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42285/tests/kraken/driver.html?testName=json-parse-financial) 11:23:35 INFO - PID 24565 | RSS: Main: 175190016 11:23:35 INFO - PID 24565 | 11:23:36 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:37 INFO - PID 24565 | RSS: Main: 175308800 11:23:37 INFO - PID 24565 | 11:23:38 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:39 INFO - PID 24565 | RSS: Main: 175063040 11:23:39 INFO - PID 24565 | 11:23:41 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:42 INFO - PID 24565 | RSS: Main: 172462080 11:23:42 INFO - PID 24565 | 11:23:45 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:45 INFO - PID 24565 | RSS: Main: 172277760 11:23:45 INFO - PID 24565 | 11:23:48 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:49 INFO - PID 24565 | RSS: Main: 172695552 11:23:49 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | Cycle 1(1): loaded http://localhost:42285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42285/tests/kraken/driver.html?testName=ai-astar) 11:23:51 INFO - PID 24565 | RSS: Main: 174505984 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | __start_tp_report 11:23:51 INFO - PID 24565 | _x_x_mozilla_page_load 11:23:51 INFO - PID 24565 | _x_x_mozilla_page_load_details 11:23:51 INFO - PID 24565 | |i|pagename|runs| 11:23:51 INFO - PID 24565 | |0;ai-astar;109;112;106;107;106;106;109;107;109;107 11:23:51 INFO - PID 24565 | |1;audio-beat-detection;116;119;116;116;126;119;117;117;116;122 11:23:51 INFO - PID 24565 | |2;audio-dft;162;162;162;160;161;164;164;166;165;178 11:23:51 INFO - PID 24565 | |3;audio-fft;73;73;73;74;75;82;75;76;74;74 11:23:51 INFO - PID 24565 | |4;audio-oscillator;79;79;78;77;89;79;81;77;78;78 11:23:51 INFO - PID 24565 | |5;imaging-gaussian-blur;114;114;110;115;113;114;114;115;114;114 11:23:51 INFO - PID 24565 | |6;imaging-darkroom;147;147;148;148;149;147;147;149;148;148 11:23:51 INFO - PID 24565 | |7;imaging-desaturate;94;93;94;94;95;94;94;95;96;94 11:23:51 INFO - PID 24565 | |8;json-parse-financial;52;52;53;53;52;52;54;55;53;52 11:23:51 INFO - PID 24565 | |9;json-stringify-tinderbox;38;37;38;39;37;38;38;38;38;37 11:23:51 INFO - PID 24565 | |10;stanford-crypto-aes;76;76;83;76;74;75;75;76;73;73 11:23:51 INFO - PID 24565 | |11;stanford-crypto-ccm;117;121;130;126;117;118;120;124;133;125 11:23:51 INFO - PID 24565 | |12;stanford-crypto-pbkdf2;162;171;175;171;169;186;167;177;175;168 11:23:51 INFO - PID 24565 | |13;stanford-crypto-sha256-iterative;67;64;67;62;62;64;70;65;65;63 11:23:51 INFO - PID 24565 | __end_tp_report 11:23:51 INFO - PID 24565 | __start_cc_report 11:23:51 INFO - PID 24565 | _x_x_mozilla_cycle_collect,921 11:23:51 INFO - PID 24565 | __end_cc_report 11:23:51 INFO - PID 24565 | __startTimestamp1504895031252__endTimestamp 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | ------- Summary: start ------- 11:23:51 INFO - PID 24565 | Number of tests: 14 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#0] ai-astar Cycles:10 Average:107.80 Median:108.00 stddev:1.93 (1.8%) stddev-sans-first:2.00 11:23:51 INFO - PID 24565 | Values: 109.0 112.0 106.0 107.0 106.0 106.0 109.0 107.0 109.0 107.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:118.00 stddev:3.31 (2.8%) stddev-sans-first:3.39 11:23:51 INFO - PID 24565 | Values: 116.0 119.0 116.0 116.0 126.0 119.0 117.0 117.0 116.0 122.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:5.13 (3.1%) stddev-sans-first:5.36 11:23:51 INFO - PID 24565 | Values: 162.0 162.0 162.0 160.0 161.0 164.0 164.0 166.0 165.0 178.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.69 (3.6%) stddev-sans-first:2.76 11:23:51 INFO - PID 24565 | Values: 73.0 73.0 73.0 74.0 75.0 82.0 75.0 76.0 74.0 74.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:3.54 (4.5%) stddev-sans-first:3.75 11:23:51 INFO - PID 24565 | Values: 79.0 79.0 78.0 77.0 89.0 79.0 81.0 77.0 78.0 78.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.50 11:23:51 INFO - PID 24565 | Values: 114.0 114.0 110.0 115.0 113.0 114.0 114.0 115.0 114.0 114.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:23:51 INFO - PID 24565 | Values: 147.0 147.0 148.0 148.0 149.0 147.0 147.0 149.0 148.0 148.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 11:23:51 INFO - PID 24565 | Values: 94.0 93.0 94.0 94.0 95.0 94.0 94.0 95.0 96.0 94.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 11:23:51 INFO - PID 24565 | Values: 52.0 52.0 53.0 53.0 52.0 52.0 54.0 55.0 53.0 52.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 11:23:51 INFO - PID 24565 | Values: 38.0 37.0 38.0 39.0 37.0 38.0 38.0 38.0 38.0 37.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:2.83 (3.7%) stddev-sans-first:3.00 11:23:51 INFO - PID 24565 | Values: 76.0 76.0 83.0 76.0 74.0 75.0 75.0 76.0 73.0 73.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:124.50 stddev:5.51 (4.4%) stddev-sans-first:5.38 11:23:51 INFO - PID 24565 | Values: 117.0 121.0 130.0 126.0 117.0 118.0 120.0 124.0 133.0 125.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:6.59 (3.8%) stddev-sans-first:5.89 11:23:51 INFO - PID 24565 | Values: 162.0 171.0 175.0 171.0 169.0 186.0 167.0 177.0 175.0 168.0 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.51 (3.9%) stddev-sans-first:2.55 11:23:51 INFO - PID 24565 | Values: 67.0 64.0 67.0 62.0 62.0 64.0 70.0 65.0 65.0 63.0 11:23:51 INFO - PID 24565 | -------- Summary: end -------- 11:23:51 INFO - PID 24565 | 11:23:51 INFO - PID 24565 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:23:51 INFO - TEST-INFO | 24565: exit 0 11:23:51 INFO - TEST-OK | kraken | took 60644ms 11:23:51 INFO - SUITE-END | took 1169s 11:23:52 INFO - Completed test suite (00:19:30) 11:23:52 INFO - javascript benchmark 11:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8478.052870715921, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.1469095998596, 3118.0645806258117, 3132.185631735748, 3135.9529607055883, 3149.212696825793, 6161.815145545641, 6167.907481387771, 6248.500119990401, 6274.811755647338, 6286.497080233582, 6253.155823963763, 6341.492680585554, 6405.42351188393, 6487.675616219182, 6504.0, 5831.241938548004, 5871.031279838843, 5924.881502369961, 5946.494547963428, 5968.31364393096, 5830.795922142725, 5840.474357307841, 5885.234919460486, 5956.52347812174, 5988.161657367972, 5763.1067184586245, 5781.831813070099, 5804.738786754606, 5812.360640329561, 5855.4144585541535, 5742.339630942453, 5787.71061446926, 5814.0, 5826.766929322822, 5828.03837366834, 5616.691081990489, 5708.0, 5794.5074668653215, 5798.362180160179, 5807.30312362515, 6234.501239900797, 6261.968690156566, 6270.6864656766975, 6305.243370795488, 6317.684115794192, 6648.202215734094, 6655.035019922133, 6664.966675166593, 6731.0913026741255, 6897.448204143657, 6814.046033555306, 6871.175458944908, 6894.379505844498, 6908.447324214101, 6913.654317284116, 6160.815175544696, 6211.534134939852, 6277.278113016971, 6290.308066112724, 6377.362263773585, 6934.895976560356, 6958.617276049765, 7051.294870512907, 7081.433485321162, 7115.92884071163, 6626.83432914181, 6683.030960510699, 6710.261871194165, 6716.798496045127, 6723.5293529452465, 6678.098456708282, 6775.390214880685, 6785.59286442815, 6860.211075726355, 6863.759768408082, 6624.90062649051, 6688.86622267552, 6726.0, 6731.427828634621, 6808.9659551701925, 6663.06717059612, 6816.318368163144, 6819.5908245505425, 6844.178698556205, 6849.760258390932, 5209.192575150858, 5274.26160337553, 5338.813141540028, 5351.25082488452, 5361.169018802092, 4540.0, 4617.0, 4629.259318509023, 4650.767461626905, 4663.860084197411, 5667.546596272288, 5670.716464176857, 5748.511376533042, 5813.709314534256, 5824.708764561755, 6798.66006699663, 6872.931270687329, 6898.344657257552, 6900.654967251618, 6909.032735417046, 5760.539156867524, 5778.479936805707, 5793.24687790593, 5813.709314534256, 5840.3575606683235, 5714.828555143353, 5778.711064446761, 5803.158542011469, 5825.825225243249, 5874.9118763218585, 6486.837829054311, 6563.704633291513, 6570.540062195696, 6575.079488871562, 6580.967095164589, 6734.124563806772, 6735.2927942567285, 6823.624700641512, 6841.657917104125, 6852.5203235773015, 6316.305206427198, 6461.741530338733, 6471.676416179266, 6476.773312934025, 6551.80344589663, 6584.407403333723, 6593.439557637655, 6596.439302659328, 6600.438962688226, 6672.666366681549, 6870.0, 6878.209005964378, 6881.13985751781, 6881.174259088942, 6882.105326307548, 6400.103985441949, 6549.083128361938, 6555.2789193189665, 6559.147310849559, 6620.801375958729, 6571.0, 6633.005049242653, 6650.83372915681, 6654.83362915931, 6655.800325990228, 6366.045093236052, 6519.282878883414, 6522.641254731036, 6584.209894812653, 6610.074589557562, 6559.836004099936, 6597.868042639025, 6610.702518386588, 6645.700943457459, 6703.530752847254, 6309.274433440213, 6367.299597044229, 6407.967960160169, 6438.67806609677, 6461.0], "value": 6159.773886544027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.3154960256993, 873.423540463294, 875.1598465473147, 875.7635438431623, 880.4585180114232, 38693.80653096734, 42260.57739422605, 42276.57723422765, 42294.0, 42368.576314236845, 38934.8053259734, 39225.21549569014, 39236.21527569447, 39308.60691393085, 39313.21373572534, 7105.822354441155, 7217.13394392671, 7219.386352160072, 7221.241769614194, 7806.414518911076, 7826.09999850016, 7918.168592297812, 7920.920790792076, 7922.762317130495, 7925.801854953615, 7897.210278972114, 7984.520928744294, 7986.201379861996, 7989.161138080505, 7989.800254993614, 7765.456418050739, 7996.08045074818, 7996.880046799302, 8000.039995200584, 8002.839943201104, 7800.726974555863, 7865.292123708837, 7878.409119316017, 7878.842423151505, 7882.7241046563095, 36993.81503092494, 37066.44400333997, 37081.81459092714, 37179.62820371789, 37190.81404592987, 3572.0534058474527, 3601.045722883438, 3608.9639103608893, 3612.548431446069, 3612.747107702462, 30557.847210764026, 30623.0, 30660.846695766602, 30721.231969200726, 30737.0, 5229.137192363255, 5254.21186821976, 5256.81601143962, 5285.68285902847, 5364.0, 184244.15755842405, 184598.0, 184659.0, 184726.0, 185689.0, 47717.761411192725, 47828.28257576139, 47870.28194577084, 49939.25091123636, 50950.74524627353, 52174.0, 52222.0, 52426.737866310425, 52559.73720131375, 52604.0, 14215.218163001135, 14450.710985780226, 14466.132032078109, 16423.260953257133, 16651.916740416462, 11624.244424112405, 11635.709107272385, 11733.4133293335, 11744.236624619372, 11746.471408786625, 12954.287514186623, 13074.869251307555, 13077.607671769862, 13083.934580327228, 13123.0, 5799.39106393831, 5818.050952930816, 5898.852528686817, 5920.289565252111, 5928.584999050025, 980.152168374351, 994.6021591363512, 998.1266391907081, 1013.1337706261188, 1021.3310281765456, 21933.670994935088, 22079.33761987143, 22113.115475380804, 22219.66670499944, 22396.55206895853, 1097.286763603648, 1102.7077824376547, 1103.0734183286079, 1103.508938522366, 1122.7586068995206, 11813.88186118145, 11819.409029548488, 11824.70438239051, 11868.940655296668, 11894.82157767634, 220023.0, 220823.0, 221566.0, 222135.0, 222542.0, 52204.47795522072, 52601.684957875594, 52653.736731316865, 52717.736411317695, 52798.20802687963, 1417.9007469477037, 1431.2986636548226, 1432.7277817214697, 1435.382785402287, 1438.8633079857398, 22929.88535057314, 26726.866365668047, 27099.458010840066, 27330.04344847921, 27439.314017148932, 49191.754041229564, 49297.0, 49363.25955110748, 49380.50619493903, 49460.50539494703, 190854.0, 191918.0, 191976.0, 192623.0, 193230.0, 34380.48429273513, 34773.13067173341, 34825.82587087048, 35256.64743352534, 35262.647373525935, 42041.57958420377, 43055.1388972225, 43138.921526962076, 43546.34680479859, 43558.34662480002, 30245.243868903453, 30593.54109688401, 30641.927532536254, 30924.845375772977, 31237.375252495276, 31035.84482077575, 31102.53346199854, 31427.68572314339, 31653.20866978344, 31938.36123277475, 35284.47073293851, 35312.0, 35527.0, 35571.64428355683, 35605.64394356023, 30221.69778302189, 30570.235744106576, 30624.234394140323, 30681.8465907669, 30700.385992279582, 22658.886705566365, 22964.0, 23030.42423939348, 23099.3070207894, 23486.530269394174], "value": 17113.62040931026, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3879732294477, 568.6303902463401, 571.2973043156919, 572.8424683212116, 576.9278840144982, 22076.88961555192, 22920.083196672113, 22936.54126917465, 22941.885290573566, 22965.081396744154, 23086.191983280587, 24012.159574414898, 24042.87978560109, 24318.75681243187, 24319.878400608017, 6608.735650573972, 6739.764108256212, 6749.93250067498, 6752.0, 6756.864862702743, 6268.968655156741, 6639.33606639337, 6707.899381509281, 6742.865142697143, 6745.595264284134, 6461.612303261796, 6515.837104072389, 6516.9674151629415, 6522.510811689119, 6525.216973963131, 6511.674416279167, 6521.869562608745, 6523.119378883885, 6526.445252153572, 6527.216733991928, 5952.672603006833, 6068.6358818471035, 6164.229471316085, 6177.62934223948, 6185.0, 28197.57703634447, 28654.283642908886, 28669.713302867123, 28690.0, 28692.0, 2083.083443284965, 2098.0768461876723, 2110.915563377463, 2111.8944052797297, 2113.9788602113936, 18781.81218187828, 19161.61676766471, 19585.314513992085, 19589.608207835765, 19772.11025503856, 2396.388920825196, 2404.9639255411184, 2429.829911906167, 2436.9634455483183, 2442.9755702443103, 118022.40988795001, 123744.38127809393, 124832.0, 130179.34910325482, 130393.0, 14149.29253537319, 14181.149131051963, 14404.711905761826, 14444.350004249834, 14567.490137845125, 22194.556108877732, 22194.88902555477, 22223.555528889654, 22226.888865555567, 22229.221977230718, 10010.799784004279, 10174.135198508062, 10235.44522687397, 10286.485675716185, 10296.639617613348, 9531.426514840954, 9560.0, 9567.808643827224, 9622.278329125204, 9632.422054676741, 8742.388032837767, 8893.599788009555, 8935.463872167691, 8966.282697384193, 8975.37172397939, 2621.659184306028, 2678.491086693522, 2720.8503532305913, 2772.4177922636068, 2858.1854171561004, 925.8564922437033, 961.0581630002497, 963.8843338799389, 968.9806203876024, 972.9464879431699, 18339.659812842274, 18733.531661708566, 18839.71740423895, 18866.0, 19172.80827191738, 1017.0947856407803, 1021.4586269277146, 1021.4994652620163, 1026.9897301026895, 1036.0778906772978, 10110.006547413877, 10416.843747343795, 10425.530851111718, 10444.112250458644, 10543.578256869792, 440016.0, 441032.0, 448677.0, 455684.0, 463512.04731929046, 105382.47308763408, 106677.46661266644, 106902.46548767206, 108086.0, 110382.0, 1138.1748232531513, 1169.7017260598664, 1173.4191575170346, 1173.6303064534645, 1183.7336599265268, 16677.833221668112, 16869.578260543585, 16983.83016169872, 17152.0, 17360.652786944444, 52350.73824630852, 53208.0, 53245.733771330895, 54084.0, 54177.729111354194, 62356.376436235056, 62437.0, 62646.06030909631, 64540.6772966151, 66245.33754662392, 13427.26150061756, 13846.10000349974, 13909.652258693613, 13909.860901390857, 13947.232902190477, 21347.893260533598, 21569.460763480412, 21645.13419463204, 21705.457363566038, 21720.565588687823, 17086.57283567871, 17091.145442728062, 17461.47615571535, 17480.47558573245, 17534.123293835, 15354.539363819104, 15563.299651515936, 15590.220488975732, 16213.837861621232, 16262.024278543326, 16969.490915272563, 17272.481825545256, 17555.912220438815, 17569.0, 17780.644387111926, 13657.317134143055, 13678.452861885413, 13801.171929684251, 13802.723945520833, 13843.861561384258, 17238.913805430893, 17247.051412172452, 17250.0, 17359.0, 17388.13059347053], "value": 11592.801876293974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.6307765364525, 1381.5440904501515, 1392.867677570631, 1397.4410235905636, 1404.269779714548, 14988.625284367883, 15567.065976041431, 15610.84389156108, 15611.531654050368, 15649.295781689823, 15123.092614443114, 15186.240687965612, 15210.771838422432, 15252.084874907485, 15253.771193432107, 2774.140016594852, 2848.4872722909868, 2851.6863145054026, 2860.542313229884, 2860.9557511508256, 2711.5932610108443, 2794.9161525154277, 2870.540713485843, 2874.0946601820465, 2876.6691830439454, 2784.554471284595, 2829.236106251311, 2839.9716002839914, 2840.573913912909, 2841.3891013432108, 2628.7371262873753, 2653.283613424365, 2655.1768951624963, 2655.880485378153, 2658.069675613539, 2606.1399738086575, 2608.699999500063, 2611.347163209198, 2615.320016795628, 2630.145202809095, 14884.851151488454, 14972.550823475205, 15315.234238288042, 15320.23398830054, 15340.156291403968, 7919.089304729914, 8238.464499807553, 8242.340612751026, 8243.505389676639, 8246.257836794657, 5198.454162312978, 5288.603354748409, 5327.094393953037, 5406.189071639285, 5516.779328826842, 1837.9632407351778, 1838.8253115953962, 1882.6705326567796, 1890.3194849854042, 1899.8005209453086, 26017.219483415527, 26341.473170536483, 26456.338591535172, 26458.735412646012, 26496.602550961557, 7016.684249208798, 7343.77968660941, 7411.221821708643, 7678.347340476011, 7743.0, 17178.570535736457, 17286.913565432093, 17321.65356692859, 17356.82643173552, 17370.652586948192, 7644.388448924073, 7725.5364678119495, 7750.186230445835, 7767.02912135983, 7788.610569471503, 7039.683214255371, 7126.964365178244, 7162.534435261691, 7389.66746496409, 7482.438817088631, 5190.455002224712, 5265.578753699695, 5289.920651190235, 5322.148456246982, 5337.866553336197, 1553.3941762712552, 1584.382090984517, 1593.3148746039083, 1595.6649103688123, 1612.2825342722376, 874.152072489684, 887.0331338840566, 888.7822483491586, 903.5301643145659, 905.538175530471, 7674.8081297968, 7690.73082442123, 7696.769096927102, 7708.730194443167, 7711.228877112244, 697.6128248821952, 717.078554058033, 725.0755287009106, 726.4551586310267, 727.8944553039779, 5357.973210133924, 5515.531179849678, 5566.053770858964, 5607.579431542651, 5678.5741069419955, 20683.172673092908, 21049.89475052615, 21426.142954281964, 21622.567548648938, 21692.24077157292, 20792.792072079388, 21802.236921707983, 21962.231321903655, 21972.560548788933, 22141.557168856532, 11081.335119892832, 11591.014763745008, 11599.88400116005, 11632.185746997799, 11636.825447618292, 6983.825404364931, 9058.682946096855, 9135.40619859707, 9145.862812057958, 9186.40288381253, 17883.73174402411, 18259.0, 18332.816671833112, 18341.0, 18348.633027339645, 19128.139233734237, 19206.7118993218, 19219.903900480407, 19284.71072933879, 19779.307724229584, 9950.0, 10145.797084058426, 10157.035081667525, 10161.288709790244, 10164.644237451654, 13539.729205416033, 13678.452861885413, 13736.0, 13850.09974351664, 13857.0, 11177.944110279723, 11448.0, 11571.074314054687, 11627.0, 11650.53397864076, 10848.728781780519, 11114.722131946766, 11220.551177953117, 11365.374904380007, 11394.601188958346, 9657.082577155159, 9760.365576237522, 9846.556904939438, 9851.605935762489, 9851.802963940825, 6938.618375989167, 6942.826429339105, 6980.755673551402, 6982.0, 7034.331738484836, 7119.323664252095, 7126.714931402686, 7174.282571742784, 7198.100237470317, 7253.0], "value": 6640.3569722859675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.36039430274377, 505.0703948016147, 513.0764623677381, 522.4253321346522, 531.8989691338927, 6281.748730050798, 6352.745890164394, 6411.166548348714, 6423.903641445382, 6433.008650977295, 6229.290258737452, 6239.8128056158275, 6256.374362563742, 6330.208723909512, 6346.6826658667, 5265.447128051538, 5281.9207711884355, 5324.813631522898, 5336.412994570614, 5356.143017117262, 5071.416787069479, 5240.34495688039, 5327.600429967768, 5349.421920533433, 5355.223492593591, 5274.472552744734, 5285.127953887604, 5288.894222115556, 5295.4704529547125, 5328.573714102882, 5199.428062913076, 5220.973895130538, 5232.7964568149155, 5256.894862102775, 5297.867553311159, 4855.150348688965, 4872.806162490213, 4934.753262336869, 4935.506449355072, 4941.1847045237855, 6277.089821975788, 6307.653079080649, 6325.367463253684, 6346.714397852108, 6355.332690067568, 5951.5238780897425, 5960.850978725523, 6013.609115407528, 6057.666828324441, 6083.939160608382, 6547.869042619121, 6626.7017984190825, 6649.5012874034155, 6698.526324208667, 6722.327767223287, 5256.842294731164, 5263.842084737464, 5317.867053323659, 5333.839984800462, 5358.678479291255, 6871.14110736163, 6958.304169583052, 6971.686274117626, 6975.651217439209, 6985.406240469566, 5345.305110335709, 5393.191021346751, 5396.271503347077, 5474.808381706621, 5489.478499542537, 5571.804986825523, 5577.2191893135, 5656.462636049569, 5668.376478587352, 5674.546036317085, 6027.558838670346, 6028.939710602838, 6067.302260240041, 6069.241344831896, 6082.60463069899, 6392.3927226913365, 6762.546052598715, 6775.0, 6775.661216939232, 6778.864422711518, 1868.6262747450564, 1886.5660897993264, 1909.8376637985648, 1952.4728323352615, 1966.2233417800176, 1448.4640682947377, 1452.9418823246951, 1461.4497701510932, 1472.1314424489603, 1478.911265324084, 5712.942870571324, 5772.460117548266, 5777.0, 5778.913316300259, 5799.681017543991, 6622.9006564901565, 6775.1869775626255, 6814.5467631653555, 6824.590524568443, 6872.518923675295, 5753.050746626844, 5801.445864995958, 5805.82582522525, 5808.970955145282, 5818.8761102197395, 3572.3391172633146, 3621.0042238384126, 3629.546306711661, 3640.8361623726464, 3645.5260816093737, 6500.252470965899, 6550.213974323112, 6551.772397384912, 6565.883799754053, 6624.370684785034, 6921.6193109379465, 6931.549449285781, 6943.79168624942, 6967.616781076988, 6986.825329366807, 6506.186726659168, 6523.3150519194805, 6530.902036469457, 6535.640539770168, 6536.24833144185, 6792.66036698173, 6810.659467026728, 6840.0, 6845.965770171118, 6847.589144651337, 6750.392464678006, 6764.289749576224, 6784.728610855708, 6812.761553345609, 6815.454763618799, 6350.7777227796805, 6435.292117866938, 6480.837979050561, 6482.837929051623, 6521.804345869631, 4975.875603109951, 4979.701217926936, 5013.623978201576, 5046.621503387188, 5047.350141175765, 6603.834904127435, 6725.293844146294, 6823.078884350549, 6859.862802744017, 6884.93115068863, 6311.431971122621, 6502.479801615765, 6568.343165683394, 6575.934240657532, 6612.355057976848, 6495.188101487314, 6528.281888992112, 6589.868202636017, 6604.438622717123, 6635.867282654416, 6332.335104814112, 6393.392627700361, 6412.6793660317735, 6536.869262614816, 6561.670606934469, 6554.180727409074, 6581.473482121323, 6630.3038180992235, 6650.672264707314, 6664.466842652673, 6299.055141728777, 6333.683315834282, 6410.551261411656, 6425.485961123192, 6431.549791514549], "value": 5230.367112497291, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.1664210605189, 904.0823564082461, 915.4964769376845, 919.5632074764487, 930.6417029443664, 19919.302824401148, 19964.50088747782, 20332.390028299156, 20457.386278411635, 20461.99999999998, 19183.616327673437, 19413.417597472064, 19479.220831166735, 19491.122899469523, 19528.70706939397, 939.8543225800012, 952.9714108576753, 953.1945506047414, 955.4506158958592, 955.8709574207497, 944.9338546301761, 966.893641699416, 975.5805003848342, 985.7683444390562, 986.9358491698017, 1025.5692609104158, 1025.7692019295673, 1028.5731421460084, 1030.1295405382477, 1030.1912998296339, 965.1651321606795, 1001.5042553935775, 1004.6634377483551, 1005.2762011351815, 1018.801333739921, 738.3797610007566, 742.3801126059747, 744.2111361956344, 744.5941961630924, 744.8361360500735, 17976.19107140169, 18176.818231817644, 18204.089795510172, 18206.271749130017, 18233.088345582666, 21499.785002149936, 22319.218827341127, 22381.328560143058, 22396.0, 22417.887910560505, 16480.084610472575, 16736.916315418344, 16746.330146794236, 16750.497485075466, 16791.748123778154, 3419.093940105849, 3467.098554375855, 3469.2194256292387, 3470.7570470067108, 3471.3057388522398, 140470.0, 143065.0, 144118.55881441158, 144195.2790236042, 147391.26304368518, 16210.43263485796, 16491.6701665966, 16674.249658765384, 16724.41464548759, 16733.66532669364, 27584.172474825387, 28891.711082889324, 29048.7095129046, 29092.127236182947, 29147.85426072856, 8112.1887811219585, 8115.1073381927945, 8170.959145204236, 8203.876941845878, 8225.424220304521, 3933.5083114610675, 4023.436718859362, 4048.4939382577177, 4049.5950404959267, 4067.7152599317765, 5337.759800808973, 5441.374241962146, 5452.863678407992, 5469.699166545799, 5472.945270547323, 931.9207867331353, 947.5309721687809, 955.3551352836807, 960.6349587156835, 972.6255391674256, 686.8111269400955, 699.2168770976539, 708.3553965891015, 713.0587624335827, 721.4476652323854, 10857.131429485622, 11548.364839933884, 11616.282789507446, 12569.371531423392, 12606.55877044299, 671.3521451799037, 671.375620672779, 677.2448719677623, 695.6486974078058, 703.057902410772, 5282.973585132127, 5314.335708036496, 5471.671699698031, 5483.862903427446, 5516.034693928546, 119694.0, 121709.0, 121993.34019979415, 122301.0, 126100.36949815192, 105964.0, 106207.0, 107973.46013269883, 109557.0, 110734.44632776784, 94715.52642236883, 96161.0, 98540.0, 100016.99983000223, 100673.0, 9956.900430995598, 10048.447335396624, 10169.84745228837, 10219.233557483367, 10337.37975721459, 44095.0, 45144.0, 45605.54394456013, 45710.77144614256, 45727.0, 58271.417285826596, 58769.70615146897, 59695.40304596898, 60046.0, 61560.69219653873, 15072.321745521696, 15594.688106238038, 15626.0, 15626.687466250383, 15723.371065157266, 17022.14889255557, 17052.74420883663, 17139.228734706718, 17300.913495432444, 17304.13479326054, 14006.0, 14065.648358791112, 14079.436822526985, 14345.282735863373, 14370.85629143737, 15278.770818437955, 15476.380944762084, 15552.222388880737, 15609.765853511979, 15731.764023539426, 14487.855121449073, 14691.926540367229, 14715.779263311273, 14832.925835370754, 14854.183019933575, 11016.614418495314, 11089.944550277198, 11181.552737890719, 11239.60661376848, 11277.097832173242, 10850.945745271223, 10997.670069897917, 11001.889981100407, 11096.167787415814, 11261.549538018387], "value": 8748.507796425682, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 106.0, 107.0, 106.0, 106.0, 109.0, 107.0, 109.0, 107.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 116.0, 116.0, 126.0, 119.0, 117.0, 117.0, 116.0, 122.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 164.0, 164.0, 166.0, 165.0, 178.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 75.0, 82.0, 75.0, 76.0, 74.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 77.0, 89.0, 79.0, 81.0, 77.0, 78.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 115.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0, 149.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 52.0, 52.0, 54.0, 55.0, 53.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 39.0, 37.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 83.0, 76.0, 74.0, 75.0, 75.0, 76.0, 73.0, 73.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 130.0, 126.0, 117.0, 118.0, 120.0, 124.0, 133.0, 125.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 171.0, 175.0, 171.0, 169.0, 186.0, 167.0, 177.0, 175.0, 168.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 67.0, 62.0, 62.0, 64.0, 70.0, 65.0, 65.0, 63.0], "value": 64.9, "unit": "score"}]}]} 11:23:52 INFO - Return code: 0 11:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:52 INFO - # TBPL SUCCESS # 11:23:52 INFO - Running post-action listener: _package_coverage_data 11:23:52 INFO - Running post-action listener: _resource_record_post_action 11:23:52 INFO - [mozharness: 2017-09-08 18:23:52.545381Z] Finished run-tests step (success) 11:23:52 INFO - Running post-run listener: _resource_record_post_run 11:23:52 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 309735424; Read time: 224; Write time: 164956 11:23:52 INFO - TinderboxPrint: CPU usage
13.1% 11:23:52 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 224 11:23:52 INFO - TinderboxPrint: I/O write bytes / time
309,735,424 / 164,956 11:23:52 INFO - TinderboxPrint: CPU idle
8,222.6 (86.9%) 11:23:52 INFO - TinderboxPrint: CPU user
1,191.2 (12.6%) 11:23:52 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12595200; Read time: 0; Write time: 3360 11:23:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:23:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 12288; Write bytes: 297140224; Read time: 224; Write time: 161596 11:23:53 INFO - Running post-run listener: _upload_blobber_files 11:23:53 INFO - Blob upload gear active. 11:23:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:53 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 11:23:53 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:53 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:59 INFO - (blobuploader) - INFO - Done attempting. 11:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:00 INFO - (blobuploader) - INFO - Done attempting. 11:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:01 INFO - (blobuploader) - INFO - Done attempting. 11:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:02 INFO - (blobuploader) - INFO - Done attempting. 11:24:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:02 INFO - Return code: 0 11:24:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d10ab038ddc5601b78b55332e8690c1c56c94c021ecadca1e5bb974772871060a3e75bd262a492223ae805d8bc9c41daf4bad96389113a04ed64a2becf3c64ca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974f454af27c6dfcbd049bec761611ff6da14e12564a634cd0fa4efe0c16864f1ff89e81504e25f2992656a13dc1be0115069fda9bfb92aa13ace27bee5ed7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcdfd83e851283b83b1e6b452bd37e7a7a4e425c24b9c992bf49c924b4f72421ec2607d3861ad0b3006ce3ffcf81d7b9cb7afcb057fbea7c88b326c0c7be0ff5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cc0d67b46db969bc23566f4c50ae2349fd6505fe46d752117a5282f0a7c6bb023278c88069bf22ddb47ea5ce970021b901255e726d0f726f2497ca9ba61ef59"} 11:24:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:02 INFO - Contents: 11:24:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d10ab038ddc5601b78b55332e8690c1c56c94c021ecadca1e5bb974772871060a3e75bd262a492223ae805d8bc9c41daf4bad96389113a04ed64a2becf3c64ca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974f454af27c6dfcbd049bec761611ff6da14e12564a634cd0fa4efe0c16864f1ff89e81504e25f2992656a13dc1be0115069fda9bfb92aa13ace27bee5ed7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcdfd83e851283b83b1e6b452bd37e7a7a4e425c24b9c992bf49c924b4f72421ec2607d3861ad0b3006ce3ffcf81d7b9cb7afcb057fbea7c88b326c0c7be0ff5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cc0d67b46db969bc23566f4c50ae2349fd6505fe46d752117a5282f0a7c6bb023278c88069bf22ddb47ea5ce970021b901255e726d0f726f2497ca9ba61ef59"} 11:24:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:02 INFO - Copying logs to upload dir... 11:24:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.238268 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-08 11:24:03.242533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:03.246243) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274 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-Non-PGO/sha512/d10ab038ddc5601b78b55332e8690c1c56c94c021ecadca1e5bb974772871060a3e75bd262a492223ae805d8bc9c41daf4bad96389113a04ed64a2becf3c64ca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974f454af27c6dfcbd049bec761611ff6da14e12564a634cd0fa4efe0c16864f1ff89e81504e25f2992656a13dc1be0115069fda9bfb92aa13ace27bee5ed7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcdfd83e851283b83b1e6b452bd37e7a7a4e425c24b9c992bf49c924b4f72421ec2607d3861ad0b3006ce3ffcf81d7b9cb7afcb057fbea7c88b326c0c7be0ff5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cc0d67b46db969bc23566f4c50ae2349fd6505fe46d752117a5282f0a7c6bb023278c88069bf22ddb47ea5ce970021b901255e726d0f726f2497ca9ba61ef59"} build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010085 build_url: 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d10ab038ddc5601b78b55332e8690c1c56c94c021ecadca1e5bb974772871060a3e75bd262a492223ae805d8bc9c41daf4bad96389113a04ed64a2becf3c64ca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98974f454af27c6dfcbd049bec761611ff6da14e12564a634cd0fa4efe0c16864f1ff89e81504e25f2992656a13dc1be0115069fda9bfb92aa13ace27bee5ed7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bcdfd83e851283b83b1e6b452bd37e7a7a4e425c24b9c992bf49c924b4f72421ec2607d3861ad0b3006ce3ffcf81d7b9cb7afcb057fbea7c88b326c0c7be0ff5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cc0d67b46db969bc23566f4c50ae2349fd6505fe46d752117a5282f0a7c6bb023278c88069bf22ddb47ea5ce970021b901255e726d0f726f2497ca9ba61ef59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:03.277356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:03.277887) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504892959.901672-1175682274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:03.328176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:24:03.328500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:24:03.328793) ========= ========= Total master_lag: 0.51 =========