builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-019 starttime: 1506565802.88 results: success (0) revision: e1f660fc493bc4bf2f91b6df94bc98e8e3840c42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:02.875901) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:02.876396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:02.876705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:02.914898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:02.915300) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 19:30:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.8M=0s 2017-09-27 19:30:03 (31.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.253722 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:03.240261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:03.240604) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:03.290958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 19:30:03.291342) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1f660fc493bc4bf2f91b6df94bc98e8e3840c42 --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 e1f660fc493bc4bf2f91b6df94bc98e8e3840c42 --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=78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 19:30:03,193 truncating revision to first 12 chars 2017-09-27 19:30:03,193 Setting DEBUG logging. 2017-09-27 19:30:03,193 attempt 1/10 2017-09-27 19:30:03,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1f660fc493b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 19:30:04,453 unpacking tar archive at: mozilla-central-e1f660fc493b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.579082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 19:30:04.888528) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:04.888871) ========= script_repo_revision: e1f660fc493bc4bf2f91b6df94bc98e8e3840c42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:04.889659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:04.889942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 19:30:04.903880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-27 19:30:04.904283) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:30:05 INFO - MultiFileLogger online at 20170927 19:30:05 in /builds/slave/test 19:30:05 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 19:30:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:30:05 INFO - {'append_to_log': False, 19:30:05 INFO - 'base_work_dir': '/builds/slave/test', 19:30:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:30:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:30:05 INFO - 'branch': 'Firefox-Non-PGO', 19:30:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:30:05 INFO - 'code_coverage': False, 19:30:05 INFO - 'config_files': ('talos/linux_config.py',), 19:30:05 INFO - 'default_actions': ('clobber', 19:30:05 INFO - 'read-buildbot-config', 19:30:05 INFO - 'download-and-extract', 19:30:05 INFO - 'populate-webroot', 19:30:05 INFO - 'create-virtualenv', 19:30:05 INFO - 'install', 19:30:05 INFO - 'setup-mitmproxy', 19:30:05 INFO - 'run-tests'), 19:30:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:30:05 INFO - 'disable_ccov_upload': False, 19:30:05 INFO - 'disable_stylo': False, 19:30:05 INFO - 'download_minidump_stackwalk': True, 19:30:05 INFO - 'download_symbols': 'ondemand', 19:30:05 INFO - 'enable_stylo': False, 19:30:05 INFO - 'enable_webrender': False, 19:30:05 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 19:30:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:30:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:30:05 INFO - 'gecko_profile': False, 19:30:05 INFO - 'gecko_profile_interval': 0, 19:30:05 INFO - 'installer_path': 'installer.exe', 19:30:05 INFO - 'log_level': 'info', 19:30:05 INFO - 'log_name': 'talos', 19:30:05 INFO - 'log_to_console': True, 19:30:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:30:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:30:05 INFO - 'opt_config_files': (), 19:30:05 INFO - 'pip_index': False, 19:30:05 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 19:30:05 INFO - 'system_bits': '32', 19:30:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:30:05 INFO - 'title': 'talos-linux64-ix-019', 19:30:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:30:05 INFO - 'use_talos_json': True, 19:30:05 INFO - 'verify': 'False', 19:30:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:30:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:30:05 INFO - 'work_dir': 'build'} 19:30:05 INFO - [mozharness: 2017-09-28 02:30:05.024821Z] Running clobber step. 19:30:05 INFO - Running pre-action listener: _resource_record_pre_action 19:30:05 INFO - Running main action method: clobber 19:30:05 INFO - rmtree: /builds/slave/test/build 19:30:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:30:05 INFO - Running post-action listener: _resource_record_post_action 19:30:05 INFO - [mozharness: 2017-09-28 02:30:05.980520Z] Finished clobber step (success) 19:30:05 INFO - [mozharness: 2017-09-28 02:30:05.980618Z] Running read-buildbot-config step. 19:30:05 INFO - Running pre-action listener: _resource_record_pre_action 19:30:05 INFO - Running main action method: read_buildbot_config 19:30:05 INFO - Using buildbot properties: 19:30:05 INFO - { 19:30:05 INFO - "project": "", 19:30:05 INFO - "product": "firefox", 19:30:05 INFO - "who": "philringnalda@gmail.com", 19:30:05 INFO - "installer_path": "public/build/target.tar.bz2", 19:30:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 19:30:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:30:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 19:30:05 INFO - "stage_platform": "linux64", 19:30:05 INFO - "basedir": "/builds/slave/test", 19:30:05 INFO - "buildnumber": 50, 19:30:05 INFO - "platform": "ubuntu64_hw", 19:30:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:30:05 INFO - "slavebuilddir": "test", 19:30:05 INFO - "taskId": "U5J4qpnaT9m8MOQXe3n8Gw", 19:30:05 INFO - "branch": "mozilla-central", 19:30:05 INFO - "script_repo_revision": "production", 19:30:05 INFO - "revision": "e1f660fc493bc4bf2f91b6df94bc98e8e3840c42", 19:30:05 INFO - "slavename": "talos-linux64-ix-019", 19:30:05 INFO - "repo_path": "mozilla-central" 19:30:05 INFO - } 19:30:05 INFO - Finding installer, test and symbols from parent task. 19:30:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U5J4qpnaT9m8MOQXe3n8Gw'}, attempt #1 19:30:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U5J4qpnaT9m8MOQXe3n8Gw'}, attempt #1 19:30:06 INFO - Task dependencies: ZYcIjL_vT_-NqcCrfCI1Aw 19:30:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw'}, attempt #1 19:30:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2 19:30:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.test_packages.json 19:30:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.crashreporter-symbols.zip 19:30:07 INFO - Running post-action listener: _resource_record_post_action 19:30:07 INFO - [mozharness: 2017-09-28 02:30:07.283658Z] Finished read-buildbot-config step (success) 19:30:07 INFO - [mozharness: 2017-09-28 02:30:07.283884Z] Running download-and-extract step. 19:30:07 INFO - Running pre-action listener: _resource_record_pre_action 19:30:07 INFO - Running main action method: download_and_extract 19:30:07 INFO - mkdir: /builds/slave/test/build/tests 19:30:07 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')]} 19:30:07 INFO - trying https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.test_packages.json 19:30:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:30:07 INFO - Downloaded 989 bytes. 19:30:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:30:07 INFO - Using the following test package requirements: 19:30:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:30:07 INFO - u'common': [u'target.common.tests.zip'], 19:30:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:30:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:30:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:30:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:30:07 INFO - u'mozbase': [u'target.common.tests.zip'], 19:30:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:30:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:30:07 INFO - u'web-platform': [u'target.common.tests.zip', 19:30:07 INFO - u'target.web-platform.tests.tar.gz'], 19:30:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:30:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 19:30:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.common.tests.zip 19:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:30:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.common.tests.zip into memory 19:30:09 INFO - Content-Length response header: 54946111 19:30:09 INFO - Bytes received: 54946111 19:30:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.talos.tests.zip 19:30:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:30:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.talos.tests.zip into memory 19:30:21 INFO - Content-Length response header: 14521162 19:30:21 INFO - Bytes received: 14521162 19:30: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')]} 19:30:21 INFO - trying https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2 19:30:21 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:30:22 INFO - Downloaded 61645996 bytes. 19:30:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2 19:30:22 INFO - mkdir: /builds/slave/test/properties 19:30:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:22 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:22 INFO - Contents: 19:30:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2 19:30:22 INFO - Running post-action listener: _resource_record_post_action 19:30:22 INFO - Running post-action listener: find_tests_for_verification 19:30:22 INFO - Running post-action listener: set_extra_try_arguments 19:30:22 INFO - [mozharness: 2017-09-28 02:30:22.598701Z] Finished download-and-extract step (success) 19:30:22 INFO - [mozharness: 2017-09-28 02:30:22.598797Z] Running populate-webroot step. 19:30:22 INFO - Running pre-action listener: _resource_record_pre_action 19:30:22 INFO - Running main action method: populate_webroot 19:30:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:30:22 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['tresize', 19:30:22 INFO - 'tcanvasmark']}, 19:30:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:30:22 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['dromaeo_css', 19:30:22 INFO - 'kraken']}, 19:30:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:22 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'tests': ['damp', 'tps']}, 19:30:22 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['damp', 'tps']}, 19:30:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:30:22 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['dromaeo_dom']}, 19:30:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:30:22 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['basic_compositor_video', 19:30:22 INFO - 'glvideo']}, 19:30:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:30:22 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['ts_paint_webext', 19:30:22 INFO - 'tp5o_webext']}, 19:30:22 INFO - 'other-e10s': {'tests': ['a11yr', 19:30:22 INFO - 'ts_paint', 19:30:22 INFO - 'tpaint', 19:30:22 INFO - 'sessionrestore', 19:30:22 INFO - 'sessionrestore_many_windows', 19:30:22 INFO - 'sessionrestore_no_auto_restore', 19:30:22 INFO - 'tabpaint', 19:30:22 INFO - 'cpstartup']}, 19:30:22 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['a11yr', 19:30:22 INFO - 'ts_paint', 19:30:22 INFO - 'tpaint', 19:30:22 INFO - 'sessionrestore', 19:30:22 INFO - 'sessionrestore_many_windows', 19:30:22 INFO - 'sessionrestore_no_auto_restore', 19:30:22 INFO - 'tabpaint', 19:30:22 INFO - 'cpstartup']}, 19:30:22 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 19:30:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 19:30:22 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['perf_reftest_singletons']}, 19:30:22 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['perf_reftest']}, 19:30:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:30:22 INFO - 'tsvgr_opacity', 19:30:22 INFO - 'tart', 19:30:22 INFO - 'tscrollx', 19:30:22 INFO - 'tsvg_static']}, 19:30:22 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['tsvgx', 19:30:22 INFO - 'tsvgr_opacity', 19:30:22 INFO - 'tart', 19:30:22 INFO - 'tscrollx', 19:30:22 INFO - 'tsvg_static']}, 19:30:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:30:22 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'talos_options': ['--disable-stylo'], 19:30:22 INFO - 'tests': ['tp5o']}, 19:30:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:30:22 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 19:30:22 INFO - 'talos_options': ['--mitmproxy', 19:30:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:30:22 INFO - '--firstNonBlankPaint'], 19:30:22 INFO - 'tests': ['tp6_google', 19:30:22 INFO - 'tp6_youtube', 19:30:22 INFO - 'tp6_amazon', 19:30:22 INFO - 'tp6_facebook']}, 19:30:22 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:30:22 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 19:30:22 INFO - 'talos_options': ['--disable-stylo', 19:30:22 INFO - '--mitmproxy', 19:30:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:30:22 INFO - '--firstNonBlankPaint'], 19:30:22 INFO - 'tests': ['tp6_google', 19:30:22 INFO - 'tp6_youtube', 19:30:22 INFO - 'tp6_amazon', 19:30:22 INFO - 'tp6_facebook']}, 19:30:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:30:22 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 19:30:22 INFO - 'talos_options': ['--stylo-threads=1', 19:30:22 INFO - '--mitmproxy', 19:30:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:30:22 INFO - '--firstNonBlankPaint'], 19:30:22 INFO - 'tests': ['tp6_google', 19:30:22 INFO - 'tp6_youtube', 19:30:22 INFO - 'tp6_amazon', 19:30:22 INFO - 'tp6_facebook']}, 19:30:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'talos_options': ['--xperf_path', 19:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:22 INFO - 'tests': ['tp5n']}, 19:30:22 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 19:30:22 INFO - 'talos_options': ['--disable-stylo', 19:30:22 INFO - '--xperf_path', 19:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:22 INFO - 'tests': ['tp5n']}}} 19:30:22 INFO - Running post-action listener: _resource_record_post_action 19:30:22 INFO - [mozharness: 2017-09-28 02:30:22.614462Z] Finished populate-webroot step (success) 19:30:22 INFO - [mozharness: 2017-09-28 02:30:22.614552Z] Running create-virtualenv step. 19:30:22 INFO - Running pre-action listener: _resource_record_pre_action 19:30:22 INFO - Running main action method: create_virtualenv 19:30:22 INFO - Creating virtualenv /builds/slave/test/build/venv 19:30:22 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:30:22 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 19:30:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:30:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:30:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:30:25 INFO - Installing pip...............done. 19:30:25 INFO - Return code: 0 19:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:30:25 INFO - Reading from file tmpfile_stdout 19:30:25 INFO - Output received: 19:30:25 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 19:30:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:25 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:25 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 19:30:25 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 19:30:25 INFO - Using env: {'DISPLAY': ':0', 19:30:25 INFO - 'HOME': '/home/cltbld', 19:30:25 INFO - 'LANG': 'en_US.UTF-8', 19:30:25 INFO - 'LANGUAGE': 'en_US:en', 19:30:25 INFO - 'LOGNAME': 'cltbld', 19:30:25 INFO - 'MAIL': '/var/mail/cltbld', 19:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:25 INFO - 'MOZ_NO_REMOTE': '1', 19:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:25 INFO - 'NO_EM_RESTART': '1', 19:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:25 INFO - 'PWD': '/builds/slave/test', 19:30:25 INFO - 'SHELL': '/bin/bash', 19:30:25 INFO - 'SHLVL': '1', 19:30:25 INFO - 'TERM': 'linux', 19:30:25 INFO - 'TMOUT': '86400', 19:30:25 INFO - 'USER': 'cltbld', 19:30:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:25 INFO - '_': '/tools/buildbot/bin/python'} 19:30:26 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:30:26 INFO - Downloading/unpacking pip>=1.5 19:30:26 INFO - Running setup.py egg_info for package pip 19:30:26 INFO - warning: no files found matching 'pip/cacert.pem' 19:30:26 INFO - warning: no files found matching '*.html' under directory 'docs' 19:30:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:30:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:30:26 INFO - Installing collected packages: pip 19:30:26 INFO - Found existing installation: pip 1.1 19:30:26 INFO - Uninstalling pip: 19:30:26 INFO - Successfully uninstalled pip 19:30:26 INFO - Running setup.py install for pip 19:30:26 INFO - warning: no files found matching 'pip/cacert.pem' 19:30:26 INFO - warning: no files found matching '*.html' under directory 'docs' 19:30:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:30:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:30:26 INFO - Installing pip script to /builds/slave/test/build/venv/bin 19:30:26 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 19:30:26 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 19:30:26 INFO - Successfully installed pip 19:30:26 INFO - Cleaning up... 19:30:26 INFO - Return code: 0 19:30:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:26 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:26 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 19:30:26 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 19:30:26 INFO - Using env: {'DISPLAY': ':0', 19:30:26 INFO - 'HOME': '/home/cltbld', 19:30:26 INFO - 'LANG': 'en_US.UTF-8', 19:30:26 INFO - 'LANGUAGE': 'en_US:en', 19:30:26 INFO - 'LOGNAME': 'cltbld', 19:30:26 INFO - 'MAIL': '/var/mail/cltbld', 19:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:26 INFO - 'MOZ_NO_REMOTE': '1', 19:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:26 INFO - 'NO_EM_RESTART': '1', 19:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:26 INFO - 'PWD': '/builds/slave/test', 19:30:26 INFO - 'SHELL': '/bin/bash', 19:30:26 INFO - 'SHLVL': '1', 19:30:26 INFO - 'TERM': 'linux', 19:30:26 INFO - 'TMOUT': '86400', 19:30:26 INFO - 'USER': 'cltbld', 19:30:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:26 INFO - '_': '/tools/buildbot/bin/python'} 19:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:27 INFO - Downloading/unpacking psutil>=3.1.1 19:30:27 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 19:30:27 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 19:30:27 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 19:30:27 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 19:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:28 INFO - Installing collected packages: psutil 19:30:28 INFO - Running setup.py install for psutil 19:30:28 INFO - building 'psutil._psutil_linux' extension 19:30:28 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 19:30:29 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 19:30:29 INFO - building 'psutil._psutil_posix' extension 19:30:29 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 19:30:29 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 19:30:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:29 INFO - Successfully installed psutil 19:30:29 INFO - Cleaning up... 19:30:29 INFO - Return code: 0 19:30:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:30:29 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')]} 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:29 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')]} 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:29 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:29 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 19:30:29 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 19:30:29 INFO - Using env: {'DISPLAY': ':0', 19:30:29 INFO - 'HOME': '/home/cltbld', 19:30:29 INFO - 'LANG': 'en_US.UTF-8', 19:30:29 INFO - 'LANGUAGE': 'en_US:en', 19:30:29 INFO - 'LOGNAME': 'cltbld', 19:30:29 INFO - 'MAIL': '/var/mail/cltbld', 19:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:29 INFO - 'MOZ_NO_REMOTE': '1', 19:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:29 INFO - 'NO_EM_RESTART': '1', 19:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:29 INFO - 'PWD': '/builds/slave/test', 19:30:29 INFO - 'SHELL': '/bin/bash', 19:30:29 INFO - 'SHLVL': '1', 19:30:29 INFO - 'TERM': 'linux', 19:30:29 INFO - 'TMOUT': '86400', 19:30:29 INFO - 'USER': 'cltbld', 19:30:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:29 INFO - '_': '/tools/buildbot/bin/python'} 19:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:30:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:30:31 INFO - Installing collected packages: mozsystemmonitor 19:30:31 INFO - Running setup.py install for mozsystemmonitor 19:30:31 INFO - Successfully installed mozsystemmonitor 19:30:31 INFO - Cleaning up... 19:30:31 INFO - Return code: 0 19:30:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:31 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:31 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 19:30:31 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 19:30:31 INFO - Using env: {'DISPLAY': ':0', 19:30:31 INFO - 'HOME': '/home/cltbld', 19:30:31 INFO - 'LANG': 'en_US.UTF-8', 19:30:31 INFO - 'LANGUAGE': 'en_US:en', 19:30:31 INFO - 'LOGNAME': 'cltbld', 19:30:31 INFO - 'MAIL': '/var/mail/cltbld', 19:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:31 INFO - 'MOZ_NO_REMOTE': '1', 19:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:31 INFO - 'NO_EM_RESTART': '1', 19:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:31 INFO - 'PWD': '/builds/slave/test', 19:30:31 INFO - 'SHELL': '/bin/bash', 19:30:31 INFO - 'SHLVL': '1', 19:30:31 INFO - 'TERM': 'linux', 19:30:31 INFO - 'TMOUT': '86400', 19:30:31 INFO - 'USER': 'cltbld', 19:30:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:31 INFO - '_': '/tools/buildbot/bin/python'} 19:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:31 INFO - Downloading/unpacking jsonschema==2.5.1 19:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:30:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:30:32 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 19:30:32 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 19:30:32 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 19:30:32 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 19:30:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:30:32 INFO - warning: no files found matching '*.txt' 19:30:32 INFO - no previously-included directories found matching 'build' 19:30:32 INFO - no previously-included directories found matching 'dist' 19:30:32 INFO - no previously-included directories found matching '.git*' 19:30:32 INFO - Installing collected packages: jsonschema, functools32 19:30:32 INFO - Running setup.py install for functools32 19:30:32 INFO - warning: no files found matching '*.txt' 19:30:32 INFO - no previously-included directories found matching 'build' 19:30:32 INFO - no previously-included directories found matching 'dist' 19:30:32 INFO - no previously-included directories found matching '.git*' 19:30:32 INFO - Successfully installed jsonschema functools32 19:30:32 INFO - Cleaning up... 19:30:32 INFO - Return code: 0 19:30:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:30:32 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')]} 19:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:32 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')]} 19:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:32 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:32 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 19:30:32 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 19:30:32 INFO - Using env: {'DISPLAY': ':0', 19:30:32 INFO - 'HOME': '/home/cltbld', 19:30:32 INFO - 'LANG': 'en_US.UTF-8', 19:30:32 INFO - 'LANGUAGE': 'en_US:en', 19:30:32 INFO - 'LOGNAME': 'cltbld', 19:30:32 INFO - 'MAIL': '/var/mail/cltbld', 19:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:32 INFO - 'MOZ_NO_REMOTE': '1', 19:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:32 INFO - 'NO_EM_RESTART': '1', 19:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:32 INFO - 'PWD': '/builds/slave/test', 19:30:32 INFO - 'SHELL': '/bin/bash', 19:30:32 INFO - 'SHLVL': '1', 19:30:32 INFO - 'TERM': 'linux', 19:30:32 INFO - 'TMOUT': '86400', 19:30:32 INFO - 'USER': 'cltbld', 19:30:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:32 INFO - '_': '/tools/buildbot/bin/python'} 19:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:30:33 INFO - Cleaning up... 19:30:33 INFO - Return code: 0 19:30:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:30:33 INFO - Using env: {'DISPLAY': ':0', 19:30:33 INFO - 'HOME': '/home/cltbld', 19:30:33 INFO - 'LANG': 'en_US.UTF-8', 19:30:33 INFO - 'LANGUAGE': 'en_US:en', 19:30:33 INFO - 'LOGNAME': 'cltbld', 19:30:33 INFO - 'MAIL': '/var/mail/cltbld', 19:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:33 INFO - 'MOZ_NO_REMOTE': '1', 19:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:33 INFO - 'NO_EM_RESTART': '1', 19:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:33 INFO - 'PWD': '/builds/slave/test', 19:30:33 INFO - 'SHELL': '/bin/bash', 19:30:33 INFO - 'SHLVL': '1', 19:30:33 INFO - 'TERM': 'linux', 19:30:33 INFO - 'TMOUT': '86400', 19:30:33 INFO - 'USER': 'cltbld', 19:30:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:33 INFO - '_': '/tools/buildbot/bin/python'} 19:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:30:33 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 19:30:33 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 19:30:33 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 19:30:33 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 19:30:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:30:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:30:34 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 19:30:34 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 19:30:34 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 19:30:34 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 19:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:30:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:30:34 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 19:30:34 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 19:30:34 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 19:30:34 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 19:30:34 INFO - Downloading docopt-0.6.1.tar.gz 19:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:30:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:30:35 INFO - Running setup.py install for blobuploader 19:30:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:30:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:30:35 INFO - Running setup.py install for requests 19:30:35 INFO - Running setup.py install for docopt 19:30:35 INFO - Successfully installed blobuploader requests docopt 19:30:35 INFO - Cleaning up... 19:30:35 INFO - Return code: 0 19:30:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:35 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:35 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 19:30:35 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 19:30:35 INFO - Using env: {'DISPLAY': ':0', 19:30:35 INFO - 'HOME': '/home/cltbld', 19:30:35 INFO - 'LANG': 'en_US.UTF-8', 19:30:35 INFO - 'LANGUAGE': 'en_US:en', 19:30:35 INFO - 'LOGNAME': 'cltbld', 19:30:35 INFO - 'MAIL': '/var/mail/cltbld', 19:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:35 INFO - 'MOZ_NO_REMOTE': '1', 19:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:35 INFO - 'NO_EM_RESTART': '1', 19:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:35 INFO - 'PWD': '/builds/slave/test', 19:30:35 INFO - 'SHELL': '/bin/bash', 19:30:35 INFO - 'SHLVL': '1', 19:30:35 INFO - 'TERM': 'linux', 19:30:35 INFO - 'TMOUT': '86400', 19:30:35 INFO - 'USER': 'cltbld', 19:30:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:35 INFO - '_': '/tools/buildbot/bin/python'} 19:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:35 INFO - Running setup.py (path:/tmp/pip-RFkNRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:35 INFO - Running setup.py (path:/tmp/pip-JEZAWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:35 INFO - Running setup.py (path:/tmp/pip-GJWSA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:36 INFO - Running setup.py (path:/tmp/pip-yW45Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:36 INFO - Running setup.py (path:/tmp/pip-GbHPQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:36 INFO - Running setup.py (path:/tmp/pip-T4jz0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:36 INFO - Running setup.py (path:/tmp/pip-mBgzAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:36 INFO - Running setup.py (path:/tmp/pip-U_C8mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:36 INFO - Running setup.py (path:/tmp/pip-wPiJm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:36 INFO - Running setup.py (path:/tmp/pip-hwehkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:36 INFO - Running setup.py (path:/tmp/pip-kAp1GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:36 INFO - Running setup.py (path:/tmp/pip-SjVP_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:36 INFO - Running setup.py (path:/tmp/pip-fGAsZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:36 INFO - Running setup.py (path:/tmp/pip-6NJdsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:36 INFO - Running setup.py (path:/tmp/pip-H2Ed7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:36 INFO - Running setup.py (path:/tmp/pip-_ofqft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:36 INFO - Running setup.py (path:/tmp/pip-rr25pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:30:37 INFO - Running setup.py install for manifestparser 19:30:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozcrash 19:30:37 INFO - Running setup.py install for mozdebug 19:30:37 INFO - Running setup.py install for mozdevice 19:30:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozfile 19:30:37 INFO - Running setup.py install for mozhttpd 19:30:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozinfo 19:30:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozInstall 19:30:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozleak 19:30:37 INFO - Running setup.py install for mozlog 19:30:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Running setup.py install for moznetwork 19:30:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Running setup.py install for mozprocess 19:30:38 INFO - Running setup.py install for mozprofile 19:30:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Running setup.py install for mozrunner 19:30:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Running setup.py install for mozscreenshot 19:30:38 INFO - Running setup.py install for moztest 19:30:38 INFO - Running setup.py install for mozversion 19:30:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:30:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:30:38 INFO - Cleaning up... 19:30:38 INFO - Return code: 0 19:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:38 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')]} 19:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:38 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')]} 19:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:38 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:38 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 19:30:38 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 19:30:38 INFO - Using env: {'DISPLAY': ':0', 19:30:38 INFO - 'HOME': '/home/cltbld', 19:30:38 INFO - 'LANG': 'en_US.UTF-8', 19:30:38 INFO - 'LANGUAGE': 'en_US:en', 19:30:38 INFO - 'LOGNAME': 'cltbld', 19:30:38 INFO - 'MAIL': '/var/mail/cltbld', 19:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:38 INFO - 'MOZ_NO_REMOTE': '1', 19:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:38 INFO - 'NO_EM_RESTART': '1', 19:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:38 INFO - 'PWD': '/builds/slave/test', 19:30:38 INFO - 'SHELL': '/bin/bash', 19:30:38 INFO - 'SHLVL': '1', 19:30:38 INFO - 'TERM': 'linux', 19:30:38 INFO - 'TMOUT': '86400', 19:30:38 INFO - 'USER': 'cltbld', 19:30:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:38 INFO - '_': '/tools/buildbot/bin/python'} 19:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:39 INFO - Running setup.py (path:/tmp/pip-6fbOyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:39 INFO - Running setup.py (path:/tmp/pip-zTaSOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:39 INFO - Running setup.py (path:/tmp/pip-WJhOoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:39 INFO - Running setup.py (path:/tmp/pip-tfJSqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:39 INFO - Running setup.py (path:/tmp/pip-fo788p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:39 INFO - Running setup.py (path:/tmp/pip-d4FgrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:39 INFO - Running setup.py (path:/tmp/pip-_JRhfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:39 INFO - Running setup.py (path:/tmp/pip-Zd5_hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:39 INFO - Running setup.py (path:/tmp/pip-zOQ07N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:39 INFO - Running setup.py (path:/tmp/pip-XS6COR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:39 INFO - Running setup.py (path:/tmp/pip-SDUR5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:39 INFO - Running setup.py (path:/tmp/pip-dHUA8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:39 INFO - Running setup.py (path:/tmp/pip-P2Mh5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:39 INFO - Running setup.py (path:/tmp/pip-H0OyBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:40 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)) 19:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:40 INFO - Running setup.py (path:/tmp/pip-_DhcX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:40 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)) 19:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:40 INFO - Running setup.py (path:/tmp/pip-1sRy1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:40 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)) 19:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:40 INFO - Running setup.py (path:/tmp/pip-eAqJPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:40 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)) 19:30:40 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)) 19:30:40 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)) 19:30:40 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)) 19:30:40 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)) 19:30:40 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)) 19:30:40 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)) 19:30:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:30:40 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 19:30:40 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 19:30:40 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 19:30:40 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 19:30:41 INFO - Downloading blessings-1.6.tar.gz 19:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:30:41 INFO - Installing collected packages: blessings 19:30:41 INFO - Running setup.py install for blessings 19:30:41 INFO - Successfully installed blessings 19:30:41 INFO - Cleaning up... 19:30:41 INFO - Return code: 0 19:30:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:41 INFO - Reading from file tmpfile_stdout 19:30:41 INFO - Current package versions: 19:30:41 INFO - argparse == 1.2.1 19:30:41 INFO - blessings == 1.6 19:30:41 INFO - blobuploader == 1.2.4 19:30:41 INFO - docopt == 0.6.1 19:30:41 INFO - functools32 == 3.2.3-2 19:30:41 INFO - jsonschema == 2.5.1 19:30:41 INFO - manifestparser == 1.1 19:30:41 INFO - mozInstall == 1.13 19:30:41 INFO - mozcrash == 1.0 19:30:41 INFO - mozdebug == 0.1 19:30:41 INFO - mozdevice == 0.51 19:30:41 INFO - mozfile == 1.2 19:30:41 INFO - mozhttpd == 0.7 19:30:41 INFO - mozinfo == 0.10 19:30:41 INFO - mozleak == 0.1 19:30:41 INFO - mozlog == 3.5 19:30:41 INFO - moznetwork == 0.27 19:30:41 INFO - mozprocess == 0.25 19:30:41 INFO - mozprofile == 0.28 19:30:41 INFO - mozrunner == 6.13 19:30:41 INFO - mozscreenshot == 0.1 19:30:41 INFO - mozsystemmonitor == 0.3 19:30:41 INFO - moztest == 0.8 19:30:41 INFO - mozversion == 1.4 19:30:41 INFO - psutil == 3.1.1 19:30:41 INFO - requests == 1.2.3 19:30:41 INFO - wsgiref == 0.1.2 19:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:41 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')]} 19:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:41 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')]} 19:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:41 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 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30:41 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 19:30:41 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 19:30:41 INFO - Using env: {'DISPLAY': ':0', 19:30:41 INFO - 'HOME': '/home/cltbld', 19:30:41 INFO - 'LANG': 'en_US.UTF-8', 19:30:41 INFO - 'LANGUAGE': 'en_US:en', 19:30:41 INFO - 'LOGNAME': 'cltbld', 19:30:41 INFO - 'MAIL': '/var/mail/cltbld', 19:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:41 INFO - 'MOZ_NO_REMOTE': '1', 19:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:41 INFO - 'NO_EM_RESTART': '1', 19:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:41 INFO - 'PWD': '/builds/slave/test', 19:30:41 INFO - 'SHELL': '/bin/bash', 19:30:41 INFO - 'SHLVL': '1', 19:30:41 INFO - 'TERM': 'linux', 19:30:41 INFO - 'TMOUT': '86400', 19:30:41 INFO - 'USER': 'cltbld', 19:30:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:41 INFO - '_': '/tools/buildbot/bin/python'} 19:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:30:42 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 19:30:42 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 19:30:42 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 19:30:42 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 19:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:30:46 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)) 19:30:46 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)) 19:30:46 INFO - Installing collected packages: simplejson 19:30:46 INFO - Running setup.py install for simplejson 19:30:46 INFO - building 'simplejson._speedups' extension 19:30:46 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 19:30:47 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 19:30:47 INFO - Successfully installed simplejson 19:30:47 INFO - Cleaning up... 19:30:47 INFO - Return code: 0 19:30:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:30: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')]} 19:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30: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')]} 19:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e39b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fde9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', '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 19:30: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', 'jsonschema'] in /builds/slave/test/build 19:30: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 jsonschema 19:30:47 INFO - Using env: {'DISPLAY': ':0', 19:30:47 INFO - 'HOME': '/home/cltbld', 19:30:47 INFO - 'LANG': 'en_US.UTF-8', 19:30:47 INFO - 'LANGUAGE': 'en_US:en', 19:30:47 INFO - 'LOGNAME': 'cltbld', 19:30:47 INFO - 'MAIL': '/var/mail/cltbld', 19:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:47 INFO - 'MOZ_NO_REMOTE': '1', 19:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:47 INFO - 'NO_EM_RESTART': '1', 19:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:47 INFO - 'PWD': '/builds/slave/test', 19:30:47 INFO - 'SHELL': '/bin/bash', 19:30:47 INFO - 'SHLVL': '1', 19:30:47 INFO - 'TERM': 'linux', 19:30:47 INFO - 'TMOUT': '86400', 19:30:47 INFO - 'USER': 'cltbld', 19:30:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:47 INFO - '_': '/tools/buildbot/bin/python'} 19:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:30:47 INFO - Cleaning up... 19:30:47 INFO - Return code: 0 19:30:47 INFO - Running post-action listener: _resource_record_post_action 19:30:47 INFO - Running post-action listener: _start_resource_monitoring 19:30:47 INFO - Starting resource monitoring. 19:30:47 INFO - [mozharness: 2017-09-28 02:30:47.585650Z] Finished create-virtualenv step (success) 19:30:47 INFO - [mozharness: 2017-09-28 02:30:47.586672Z] Running install step. 19:30:47 INFO - Running pre-action listener: _resource_record_pre_action 19:30:47 INFO - Running main action method: install 19:30:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:47 INFO - Reading from file tmpfile_stdout 19:30:47 INFO - Detecting whether we're running mozinstall >=1.0... 19:30:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:30:47 INFO - Reading from file tmpfile_stdout 19:30:47 INFO - Output received: 19:30:47 INFO - Usage: mozinstall [options] installer 19:30:47 INFO - Options: 19:30:47 INFO - -h, --help show this help message and exit 19:30:47 INFO - -d DEST, --destination=DEST 19:30:47 INFO - Directory to install application into. [default: 19:30:47 INFO - "/builds/slave/test"] 19:30:47 INFO - --app=APP Application being installed. [default: firefox] 19:30:47 INFO - mkdir: /builds/slave/test/build/application 19:30:47 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'] 19:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:31:05 INFO - Reading from file tmpfile_stdout 19:31:05 INFO - Output received: 19:31:05 INFO - /builds/slave/test/build/application/firefox/firefox 19:31:05 INFO - Running post-action listener: _resource_record_post_action 19:31:05 INFO - [mozharness: 2017-09-28 02:31:05.707371Z] Finished install step (success) 19:31:05 INFO - [mozharness: 2017-09-28 02:31:05.707624Z] Running setup-mitmproxy step. 19:31:05 INFO - Running pre-action listener: _resource_record_pre_action 19:31:05 INFO - Running main action method: setup_mitmproxy 19:31:05 INFO - Skipping: mitmproxy is not required 19:31:05 INFO - Running post-action listener: _resource_record_post_action 19:31:05 INFO - [mozharness: 2017-09-28 02:31:05.708789Z] Finished setup-mitmproxy step (success) 19:31:05 INFO - [mozharness: 2017-09-28 02:31:05.709056Z] Running run-tests step. 19:31:05 INFO - Running pre-action listener: _resource_record_pre_action 19:31:05 INFO - Running pre-action listener: _set_gcov_prefix 19:31:05 INFO - Running main action method: run_tests 19:31:05 WARNING - Try message not found. 19:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:31:05 INFO - Python 2.7.3 19:31:05 INFO - Return code: 0 19:31:05 INFO - grabbing minidump binary from tooltool 19:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:05 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 0x1fdbd60>, '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 0x1fdca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:31:05 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 19:31:05 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 19:31:05 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 19:31:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:31:05 INFO - Return code: 0 19:31:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:31:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:31:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:31:05 INFO - ENV: RUST_BACKTRACE is now full 19:31:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:31:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:31:05 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/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 19:31:05 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/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 19:31:05 INFO - Using env: {'DISPLAY': ':0', 19:31:05 INFO - 'HOME': '/home/cltbld', 19:31:05 INFO - 'LANG': 'en_US.UTF-8', 19:31:05 INFO - 'LANGUAGE': 'en_US:en', 19:31:05 INFO - 'LOGNAME': 'cltbld', 19:31:05 INFO - 'MAIL': '/var/mail/cltbld', 19:31:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:05 INFO - 'MOZ_NO_REMOTE': '1', 19:31:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:05 INFO - 'NO_EM_RESTART': '1', 19:31:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:05 INFO - 'PWD': '/builds/slave/test', 19:31:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:05 INFO - 'RUST_BACKTRACE': 'full', 19:31:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:31:05 INFO - 'SHELL': '/bin/bash', 19:31:05 INFO - 'SHLVL': '1', 19:31:05 INFO - 'TERM': 'linux', 19:31:05 INFO - 'TMOUT': '86400', 19:31:05 INFO - 'USER': 'cltbld', 19:31:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:05 INFO - '_': '/tools/buildbot/bin/python'} 19:31:05 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/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 19:31:06 INFO - mozversion application_buildid: 20170928013855 19:31:06 INFO - mozversion application_changeset: e1f660fc493bc4bf2f91b6df94bc98e8e3840c42 19:31:06 INFO - mozversion application_display_name: Nightly 19:31:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:31:06 INFO - mozversion application_name: Firefox 19:31:06 INFO - mozversion application_remotingname: firefox 19:31:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:31:06 INFO - mozversion application_vendor: Mozilla 19:31:06 INFO - mozversion application_version: 58.0a1 19:31:06 INFO - mozversion platform_buildid: 20170928013855 19:31:06 INFO - mozversion platform_changeset: e1f660fc493bc4bf2f91b6df94bc98e8e3840c42 19:31:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:31:06 INFO - mozversion platform_version: 58.0a1 19:31:06 INFO - using testdate: 1506565866 19:31:06 INFO - actual date: 1506565866 19:31:06 INFO - starting webserver on 'localhost:35748' 19:31:06 INFO - SUITE-START | Running 2 tests 19:31:06 INFO - TEST-START | dromaeo_css 19:31:06 INFO - Initialising browser for dromaeo_css test... 19:31:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35748/getInfo.html -profile /tmp/tmpYe8pxQ/profile 19:31:06 INFO - TEST-INFO | started process 3630 (/builds/slave/test/build/application/firefox/firefox http://localhost:35748/getInfo.html) 19:31:13 INFO - TEST-INFO | 3630: exit 0 19:31:13 INFO - Browser initialized. 19:31:13 INFO - Running cycle 1/1 for dromaeo_css test... 19:31:13 INFO - Using env: {'DISPLAY': ':0', 19:31:13 INFO - 'HOME': '/home/cltbld', 19:31:13 INFO - 'JSGC_DISABLE_POISONING': '1', 19:31:13 INFO - 'LANG': 'en_US.UTF-8', 19:31:13 INFO - 'LANGUAGE': 'en_US:en', 19:31:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:31:13 INFO - 'LOGNAME': 'cltbld', 19:31:13 INFO - 'MAIL': '/var/mail/cltbld', 19:31:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:13 INFO - 'MOZ_CRASHREPORTER': '1', 19:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:31:13 INFO - 'MOZ_NO_REMOTE': '1', 19:31:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:13 INFO - 'NO_EM_RESTART': '1', 19:31:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:13 INFO - 'PWD': '/builds/slave/test', 19:31:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:13 INFO - 'RUST_BACKTRACE': 'full', 19:31:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:31:13 INFO - 'SHELL': '/bin/bash', 19:31:13 INFO - 'SHLVL': '1', 19:31:13 INFO - 'STYLO_FORCE_DISABLED': '1', 19:31:13 INFO - 'TERM': 'linux', 19:31:13 INFO - 'TMOUT': '86400', 19:31:13 INFO - 'USER': 'cltbld', 19:31:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:13 INFO - '_': '/tools/buildbot/bin/python'} 19:31:13 INFO - TEST-INFO | started process 3866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYe8pxQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:14 INFO - PID 3866 | 19:31:14 INFO - PID 3866 | (/builds/slave/test/build/application/firefox/firefox:3915): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:31:14 INFO - PID 3866 | 19:31:24 INFO - PID 3866 | RSS: Main: 151035904 19:31:24 INFO - PID 3866 | 19:34:21 INFO - PID 3866 | Cycle 1(1): loaded http://localhost:35748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35748/tests/dromaeo/cssquery-ext.html) 19:34:23 INFO - PID 3866 | RSS: Main: 149401600 19:34:23 INFO - PID 3866 | 19:37:24 INFO - PID 3866 | Cycle 1(1): loaded http://localhost:35748/tests/dromaeo/cssquery-ext.html (next: http://localhost:35748/tests/dromaeo/cssquery-jquery.html) 19:37:25 INFO - PID 3866 | RSS: Main: 148598784 19:37:25 INFO - PID 3866 | 19:40:27 INFO - PID 3866 | Cycle 1(1): loaded http://localhost:35748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35748/tests/dromaeo/cssquery-mootools.html) 19:40:27 INFO - PID 3866 | RSS: Main: 151584768 19:40:27 INFO - PID 3866 | 19:43:29 INFO - PID 3866 | Cycle 1(1): loaded http://localhost:35748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35748/tests/dromaeo/cssquery-prototype.html) 19:43:30 INFO - PID 3866 | RSS: Main: 150892544 19:43:30 INFO - PID 3866 | 19:46:33 INFO - PID 3866 | Cycle 1(1): loaded http://localhost:35748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35748/tests/dromaeo/cssquery-yui.html) 19:46:34 INFO - PID 3866 | RSS: Main: 154316800 19:46:34 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | Cycle 1(1): loaded http://localhost:35748/tests/dromaeo/cssquery-yui.html (next: http://localhost:35748/tests/dromaeo/cssquery-dojo.html) 19:49:35 INFO - PID 3866 | RSS: Main: 154906624 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | __start_tp_report 19:49:35 INFO - PID 3866 | _x_x_mozilla_page_load 19:49:35 INFO - PID 3866 | _x_x_mozilla_page_load_details 19:49:35 INFO - PID 3866 | |i|pagename|runs| 19:49:35 INFO - PID 3866 | |0;dojo.html;3185.1400121967067;3210.4381733196683;3219.9696097248875;3220.0500852248583;3238.821864797437;6172.845678858031;6221.3156552779155;6245.968770156149;6278.152449419327;6363.268224154218;6119.3574674659185;6121.296050954131;6122.540809439288;6152.630842149474;6165.044418115188;5653.180288858123;5658.632188907728;5670.886582268373;5719.342275638292;5830.242068531106;5757.136429535562;5809.912851307234;5820.330661973885;5842.853928651775;5914.556408269397;5782.421757824205;5797.536197104221;5873.618214816044;5876.588638795286;5877.353491115974;5613.859653508695;5698.059820129673;5756.424357564252;5773.740181691834;5824.737886795105;5718.513926316268;5737.053386191274;5788.768449262025;5790.623609465371;5798.768049278024;6210.813675589694;6220.129181914535;6254.312025677172;6263;6269.028300613412;6473.805785826433;6619.073329733841;6664.233613134503;6738.966305168492;6742.59544427331;6703.095082163943;6806.081179040815;6806.149231346082;6810.28492008337;6815.761448349284;6180.103884936659;6194.194754681907;6280.717367718464;6281.183446151971;6286.994080947026;6781.355771201728;6847.589144651237;6847.897281540781;6904.206016308089;6936.514443988873;6344.080108384258;6424.935750642434;6468.967655161694;6519.739210431624;6535.738570457129;6635.601863888182;6652.83367915806;6664.366885145903;6664.600123992576;6694.029365742038;6450.838729031718;6611.107500487469;6665.6000639960785;6667.833304167338;6710.630915299607;6644.900326495106;6663;6738.966305168541;6745.8650826983185;6748.156480439945;4803.447603525569;4849.224124140121;4860.4896485869185;4933.851984440473;4947.802087916443;4305.956940430556;4354.346847972829;4392.780360981938;4410.029793445437;4414.580614841585;5721.056025755704;5728.026235539968;5796.942030579725;5798.333191682926;5813.82558523245;6632.668366581652;6682.966585167043;6729.25978142404;6786.4570834333135;6810.353016463428;5675.347335056439;5753.964286428483;5758.769649213985;5769.653820770767;5807.5063619591965;5653;5714.371419143891;5716.685582293014;5786.07422812348;5791.218185544982;6320.209973753281;6334.936650633527;6337.588056776295;6347.809565713036;6360.173177486897;6508.967455162694;6511.218653761484;6660.766873159416;6752.020956961115;6815.318468153145;6489.805305840832;6500.28496865335;6566.80299591013;6593.637349945607;6606.47148228131;6568.540202185993;6591.6374599397495;6669.433098186709;6669.599824010575;6681.832954176184;6574.605523668595;6639.933600663931;6668.933310666831;6670.466362690876;6686.732530698718;6386.648734319471;6452.580582262138;6474.676266186766;6478.902816457663;6487.3188315226225;6455.289918108911;6538.542302039002;6567.9014814778775;6573.3098024706715;6574.605523668595;6391.936080639134;6426.29310775805;6427.55007149495;6508.511861610304;6518.543701940818;6422.293547709654;6524.086627872007;6549.4760419167305;6635.170603674541;6668.099806526056;6153.784617538544;6254.781082662267;6293.213348331458;6307.779227727007;6314.494840412848 19:49:35 INFO - PID 3866 | |1;ext.html;858.4634603372892;884.6903583745689;907.7912080221547;910.7267819654111;911.503230739247;38750.61249387505;40520.797396013055;40617.79691101548;40634.187316253694;40719.59280407199;37830.621693783054;38020.619793802056;38025.239495210146;38149.618503814956;38196.61803381972;7083.539569927964;7186.820329491752;7189.065421495198;7198.7480438184675;7200.279972002811;7124.501284910032;7234.421246300283;7239;7246.963765181166;7248.963755181217;7106.467014973872;7119.750808721696;7749.9225007749765;7944.920550794476;7951;7729.961350193241;7863.921360786376;7867.213278672144;7875.566843823587;7876.251756083163;7684.500507467053;7783.922160778433;7878.36973042161;7880.408969327266;7906.723264685708;37908.620913790786;38120.42819357712;38160.23679526394;38175;38214.617853821386;3462.117160124152;3511.6488351164935;3515.367233897897;3517.2437925846066;3527.8588856445713;31534.211644708837;31757;31800.045998620077;31843.52234716481;31874.840625796955;5112.233165025239;5117.385913690381;5140.7172605506685;5158;5169.922451163236;196486;197044;197070;197436;198273.00863495734;47703.76148119307;47961.5203847964;48196.7590162047;48430;48575;49708;49749;50133.24800128001;50146.498535014915;50379.49620503748;15315.693686126215;15784.289706963214;15803.920980395025;15809;15814.60463488422;12687.873121268854;12775.680607984874;12786.872131278567;12845.165064270792;12869.613911582668;14359.282035898163;14367.353469093707;14466.204358760158;14479.855201448061;14599.854001460062;5855.912161317584;5868;5870.501007414332;5874.707564335839;5881.529477641779;998.5855869814092;999.0558921818812;1004.6182450668845;1025.4975062219607;1027.244974943416;22599.774002260096;23039.7696023041;23043.88478057599;23062.53874922492;23149.3055208344;1110.9722256943642;1112.9721756956142;1119.3228097001197;1121.4673030310537;1123.9157063220127;11960.820587691192;12266.448009839578;12270.877291227152;12283;12453.501859925682;214616;215219;215686;215708;217129;50905.490945090074;51505.22742158871;52975.73512132492;53610.463895361325;53631;1426.0730525158522;1443.6246575890134;1446.5732608880405;1448.3482432905234;1451.3468938977292;26066.34834129162;26345.868270658524;26371.60442593401;26520.336991575365;26908.327291817863;35987.46018809772;36007.81996090003;36052.27895442024;36082.45876311805;36107.81946090253;193195;193549;194275;194511;194809;31834.044978650676;31944.840275798473;32040.5193922096;32086.518702219953;32125.518117228727;39795.80102099471;40598.1880362397;40886.38670420006;41109.177816442905;41142.382864257655;30402.391952161277;30785.230369240948;30858.845705771328;30938.226544336572;31484;29925.102246932627;30124.24689382783;30185.245368865075;30631.693683062884;30780.846095770274;32912;34132.658673412945;34402.139946501535;34519.4822077664;34739.652603473645;30324;30404.391912162075;30651.54022689706;30751.538726918665;31403.528947065355;22585.435364116027;22686;23184;23268.185613503447;23276.883615581814 19:49:35 INFO - PID 3866 | |2;jquery.html;583.1689841975184;583.716897304807;590.6013440927373;600.5165841497594;601.8104297146399;22042.008109635066;22673.659895101588;22724.88637556814;22737.204197853058;22755.203567875127;23149.30552083436;23287.767122328773;23469.647955280685;24309.027638894422;24872;6633.7678181263545;6706.26231114577;6786.524943253974;6794.694238759243;6794.898076528856;6391.169148010776;6668.733250669968;6778.864422711543;6783.966080169592;6793.490488213404;6615.735370585171;6639.73441062357;6640;6645.667716614174;6648.800535983904;6638.767643132515;6638.900416493757;6649.434798042173;6650.401463868251;6651.268360480319;5849.473547380756;6108.755649774003;6113.847153821145;6125.846853828645;6177.567570270083;29300.56049159243;29859.850700746574;29861.10416687503;29883.402331953457;29910;2051.3743308290964;2070.3995841206033;2074.6887966804948;2082.666773316277;2084.6247675418417;19086.52283692905;19446.80553194464;19746.70379944302;19809.306674266332;19815.90092049545;2356.2931120663734;2388.2391787532456;2429.319790458657;2465.7287698353166;2468.5556599812026;119917;127315;127845;128148.35925820404;136595.31702341523;14720;14823.258837058103;14889.106653600818;14906.105633662015;15350.846491534941;23541.646875296883;23553.175638852557;23578.410539736302;23627.7637223629;23848.40378990539;9844.655437059668;9860.605575776888;9878.4566848824;9881.110700037032;9918.355306905029;9064.229540489001;9077.364584479023;9174.082591740906;9196.494192819458;9247.491387973727;8980.775480613036;8989.01120876703;9073.95463022694;9198.586063627154;9198.896132464148;2611.8955241790495;2630.9605355919675;2666.4933662604044;2701.6217729517884;2764.640596722413;939.5959737313021;981.1954197557934;984.1831280037552;984.8276551603441;984.9015098490094;18946.242150313832;18969.430917072234;19448.319308824124;19585;19677.901610491856;1008.4604736465956;1046.2467023743045;1049.2130901823632;1050.2565740870118;1051.779126383468;10617.940796270559;10776.245662803529;10800.891991080145;10829.566817327219;10876.74917384511;491798;494063;498180;510524;522626;109185.45407273072;110609;111426;111792.44103779591;112890;1027.5427434791595;1080.8594882665204;1152.1877076660935;1153.8615366156116;1200.7598480303975;19956.60086798285;20014.799852001295;20044.599108017468;20196.495087622927;20296.289629862884;56935;57865.71067144637;58438.70780646239;58915.41084589099;59727.402725972184;68931;69202;70148.64925675339;71514.28485715076;71991;14354.85645143577;14870.628234293796;14884.479043233436;14890.404383824525;14895;22314.21900233484;22795.65806512937;22961.770382295963;22988.195413161127;23061.769382305964;18035.458936231935;18118.45644630663;18155;18207.635847283243;18429.723554146967;16149.596260093122;16560.66878662396;16760.497185084467;16804.159792010105;16893.070881101656;18414.079296034877;18725.625487489902;18945.33691320797;18947.0526473673;18998.810011899703;14402.639934001734;14430.206338651475;14451.349689264218;14486.420543178156;14528.709425811636;18274.36039738656;18301.084945752395;18370.357037504156;18440.631187375908;18600.813991859908 19:49:35 INFO - PID 3866 | |3;mootools.html;1323.0738483061857;1351.8310211223593;1359.3543067043163;1371.9931400342996;1373.7183877305154;14926.179060151688;15581.532554023383;15585.766213506793;15601;15608.21958902056;15325.310361033753;15404.152771597557;15467.149306788122;15470.756740272654;15472.613184670388;2718.497078040559;2835.1919702884684;2838.4181242845166;2840.7443330100286;2840.758535524483;2754.752072313491;2771.5704065869722;2813.9015134470296;2829.4624021435966;2838.858057097147;2816.957745633817;2838.3897462045657;2839;2840.4177143685497;2841.176058942904;2677.116551538007;2717.7418145276265;2721.4557088582264;2724.9591256131175;2738.821976571536;2716.4702882937836;2745.6567929008875;2749.6837863645737;2751.0783887397747;2751.683556391021;15287.853410994108;15384;15411.3835446582;15414.383424663;15439.691206175927;8132.715354962548;8397.580120993987;8410.747677569683;8416.579171041423;8417.579121043984;5290.497402746733;5468.562514998791;5553.750081246313;5565.833025009256;5578.832635020955;1911.4074636862617;1971.753530808649;1985.2158397432934;2018.4348382452936;2029.4824819671037;26921;27543.31141721453;28299.292517687016;28329.858350708113;28431.289217769514;6860;6870.862582748417;6903.205166656706;7086.362227399559;7092.078029856189;17608.55978600545;17613;17613.38353157659;17687.115644217996;17695.203715832817;7838.843223135619;8043.879341809878;8062.596870156469;8066.23370779775;8074.111847696749;7370.48406611532;7392.815179620553;7518.887216691644;7654;7656.885146722803;5257.421683614799;5336.439673834269;5404.891902162013;5414.593905457106;5456.972715136479;1507.9246037698072;1530.9846901531064;1540.345353224875;1554.1452201289471;1556.8910176287777;902.228594551662;905.3210092430677;919.558611866308;928.0951072704195;938.863864739609;7783.377329813601;7791.649375778104;7829.3736501079775;7854.253845884632;7857.410694197958;718.4467959671024;726.9345758881726;746.5371469688719;758.1622307350409;764.4152223548989;4850.708957462563;4939.53074457926;4973.676711013845;4991.425986011655;5044.924326135111;21889.890550547465;22040.559188816133;22703.978320975595;22859.31422057341;22976.425589360064;21606.567868642538;22142.667859982113;22272.66591001136;22342.106315747187;22568.435789105075;10685.626003089854;11031.338119712844;11334.659960201207;11544.365059921785;11582.841715828517;8529.95735021321;8814.162654547808;8860.689875854314;8878.955605221932;8899.911000889908;18772.436826895217;19366.12852421616;19728;19856.503587409854;19957.501062473555;19434.8056519433;19716;19748.901255494206;19889.60220795605;20562.897185513975;11264.211505194886;11535.480903359201;11555.595554155565;11561.537538498365;11562.826557601475;14006.439742410597;14229.857701423267;14398.42406303736;14422.350994205077;14468.27658617044;11492.310461372344;11707.707307317385;11968.281903085843;12050.51797928073;12117.636470905887;10746.086582640562;11060.225784195029;11149.83275250888;11389.373584452604;11572.652820415064;9996.750081248027;10018.248631352531;10040.69877903664;10128.392296462236;10242.948785256027;7008.9649551753955;7039.507234493536;7071.964640176766;7117.928820711727;7121.537100088478;7744.728934487266;7832.647530861239;7840.686372545034;7861.8034549134445;7888.68445262206 19:49:35 INFO - PID 3866 | |4;prototype.html;505.3657659637157;510.130227961326;529.0741202894934;540.8053100883682;540.8458589302048;6121.143039974407;6167.537434692399;6211.627302361861;6271.937280627192;6333.683315834213;6042.305134909487;6161.291451483081;6172.475339596129;6207.906881396782;6210;4907.214845624683;5183.50756678115;5189.532942035216;5215.869603259911;5217.37391513019;5011.523905228997;5021.422536408305;5083.618728595352;5088.592912566985;5094.566961808251;4949.430815456232;4964.503549645043;4997.675151115166;5017.347744793172;5040.546350828425;4989.825356112518;5001.749912504397;5022.748862556894;5039.874003149932;5045.369328833895;4513.526079761644;4537.228671125917;4540.8864778380475;4549.567791059844;4563.269876819693;6123.540734444934;6204.689765511752;6242.843928901769;6283;6306.49548036156;5671.234383358235;5698.6865722385255;5710.942890571083;5711.7715291388295;5767.740451679642;6581.901271480931;6608.834779130512;6636.601803891782;6645.734170633169;6659.101021362151;4916;4921.926171107436;4927.704337739747;4970.502949705036;4973.701577905337;6798.966005169992;6908.412784913288;6952.200496942815;6954.582725036514;6978.162620485524;5053.772580233898;5061.089003979319;5061.645684802029;5097.158968770112;5100;5177.792888284426;5194.92207616886;5197.974010129925;5207.791688332424;5224.947750522522;5686.97156514223;5699.914501282484;5730.3785964666895;5746.770129194785;5789.9710501447225;6382;6420.678966051679;6557.704903279364;6591.505637077238;6650.83372915681;1901.9809801902081;1933.5166208447888;1946.4355336952408;1955.8435325173953;1958.1384190955935;1231.445849367788;1441.0345068803717;1447.7321695486369;1452.4408102880468;1468.8751456126136;5638.887222255532;5665.1502274658305;5756.416985328984;5757.366689664133;5808.970955145197;6557.114789503356;6582.341765823379;6639.734410623521;6690.364415380531;6743.898841517381;5726.312842458931;5753.88492230153;5756.9775867669805;5784.623999440023;5837.824865254049;3525.8765943191866;3535.8939231823088;3589.8743543975834;3604.513390692223;3608.45873119029;6431.356864313625;6469.8706025880165;6546.0835483032415;6566.4418524425;6586.868262634721;6698.83252918681;6812.931870681329;6820.93179068203;6856.862862742817;6907.861842763116;6415.957946493679;6449.580777249557;6456.935430645727;6582.144321238208;6588.4070433660245;6653.006147233667;6678.966605166943;6698.765543205965;6711.4966377520905;6762;6707.597544147172;6718.529702920749;6728.899066513908;6806.8638627228165;6821.727130914906;6556.803295901131;6598.967005164944;6621.172353455818;6632.2372927114;6673.432758215412;4989.850304490871;5007.223880298559;5073.18828987375;5095.643304968765;5114.74426278692;6429.164208652845;6686.732530698718;6697.698603562754;6720.663966801738;6740.62926539045;6353.428191462605;6361.93638063632;6441.1626488556185;6530.412262896362;6616.073749675145;6467.385598368148;6470.729318649669;6518.478521718346;6593.3736295051895;6617.735290588323;6391.265004524539;6421.614703117641;6457.6771161442675;6520.836979075561;6559.245686746085;6378.489720822416;6449.6458792541325;6449.677516124081;6466.515011374072;6555.311692272243;5909.762132822532;6213.347598502092;6266;6291.993281075006;6339.270983836734 19:49:35 INFO - PID 3866 | |5;yui.html;912.2747415804439;915.4461550761789;926.4024704065882;930.1675000874218;934.593451848446;19647.41057768266;20277.797222027777;20591.38225853223;20621.27825526107;20652;18313.7252941206;18468.630627387476;18527.907360463214;18532.907335463304;18537.907310463463;900.3067637918798;903.3225081189108;904.7828521154909;909.2544113826665;910.3627460777466;967.1682353176262;977.5307852230933;979.9706008819746;980.3186785184299;980.4999450280372;999.3953658036855;1008.7831116309992;1008.8083264179819;1019.6227395863503;1022.269077609509;1001.7695929936083;1001.8897921228659;1002.2433063037397;1002.5488530161457;1005.8994100589919;716.8888822232562;721.7762493626992;730.989035164473;731.294300999538;732.560463721768;20498.18007279707;20659.17363305466;20745.273915412887;20763.792362076336;20765.961701914843;21383.465413364636;21798.346049618536;22742.772572274396;22745.886270568706;22850.542989140125;17960;17980.820191798044;18130.728039079426;18143.002134882707;18307.63384732311;3776.2447510497736;3776.8111594420443;3780.1872597391693;3803.220339830356;3805.56236032857;109344;138841.30579347038;140753;141443;144063;18230.27078916855;18363.17365718519;18407;18407.72388414175;18513.90743046276;31861.840690796398;32157.35685286328;32165.87419440355;32236.516452253236;32322.676773231968;9200.815983680423;9339.159475647224;9404.38871473352;9436.575354109082;9471.952640236892;4453.532379100147;4511.571400716926;4528.275475923902;4531.184386810406;4543.432070991126;4928.408590969107;5423.3491980962535;5517.089680202802;5542.667439953535;5572.3034620672415;1102.6030628973563;1115.520326259716;1125.352922069813;1129.0910816792398;1130.1072152999038;672.7510820996263;677.376813331736;685.7736946807541;690.4062506244626;692.2834865913856;11860.644180674593;11946.88053119475;12261;12351.876481235253;13031.739365212643;659.3241927024837;672.1027428383065;672.5023482622823;680.4556354916048;687.3023880760932;5708.771649134072;5911.852203694856;5920.437558431942;5972.761089556369;6043.214382130383;127582;127647.3617631906;130353;130545.34727326492;134171;106506;109191.90808091976;113019;113038;118211.40894295473;96179.51910240404;97491.99999999859;98038;99055.50472247737;102757.48621256846;12973.481060757464;13226.272555009567;13337.53318633843;13416.060875738605;13463.865361346652;43378.783106084265;43676.56323436725;44180.558194417645;44880.551194487634;45508.544914551756;59677;60124;60168;61304.69347653233;61552;18750.624987500447;19011.904940475208;19038.048097595343;19064.714029289848;19245.711314330016;21037.57924841525;21038.368848934555;21135.78864211338;21149;21328.253511127037;17870.5532361692;18299.634007319513;18534.351297704514;18599.53501162482;18673.15970781291;18993.905030474758;19762.604747904676;19939;20081;20112.094955726734;17792;18281.908590456962;18311.54221144482;18350.449486515427;18457.261709531467;13172.143810652276;13198.60404187876;13213.735725285249;13284;13376;13649.11280766747;13820;13840.169589824643;13929.233892135624;14001.159930404208 19:49:35 INFO - PID 3866 | __end_tp_report 19:49:35 INFO - PID 3866 | __start_cc_report 19:49:35 INFO - PID 3866 | _x_x_mozilla_cycle_collect,287 19:49:35 INFO - PID 3866 | __end_cc_report 19:49:35 INFO - PID 3866 | __startTimestamp1506566975944__endTimestamp 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | ------- Summary: start ------- 19:49:35 INFO - PID 3866 | Number of tests: 6 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | [#0] dojo.html Cycles:165 Average:6123.18 Median:6344.08 stddev:751.50 (11.8%) stddev-sans-first:717.59 19:49:35 INFO - PID 3866 | Values: 3185.1 3210.4 3220.0 3220.1 3238.8 6172.8 6221.3 6246.0 6278.2 6363.3 6119.4 6121.3 6122.5 6152.6 6165.0 5653.2 5658.6 5670.9 5719.3 5830.2 5757.1 5809.9 5820.3 5842.9 5914.6 5782.4 5797.5 5873.6 5876.6 5877.4 5613.9 5698.1 5756.4 5773.7 5824.7 5718.5 5737.1 5788.8 5790.6 5798.8 6210.8 6220.1 6254.3 6263.0 6269.0 6473.8 6619.1 6664.2 6739.0 6742.6 6703.1 6806.1 6806.1 6810.3 6815.8 6180.1 6194.2 6280.7 6281.2 6287.0 6781.4 6847.6 6847.9 6904.2 6936.5 6344.1 6424.9 6469.0 6519.7 6535.7 6635.6 6652.8 6664.4 6664.6 6694.0 6450.8 6611.1 6665.6 6667.8 6710.6 6644.9 6663.0 6739.0 6745.9 6748.2 4803.4 4849.2 4860.5 4933.9 4947.8 4306.0 4354.3 4392.8 4410.0 4414.6 5721.1 5728.0 5796.9 5798.3 5813.8 6632.7 6683.0 6729.3 6786.5 6810.4 5675.3 5754.0 5758.8 5769.7 5807.5 5653.0 5714.4 5716.7 5786.1 5791.2 6320.2 6334.9 6337.6 6347.8 6360.2 6509.0 6511.2 6660.8 6752.0 6815.3 6489.8 6500.3 6566.8 6593.6 6606.5 6568.5 6591.6 6669.4 6669.6 6681.8 6574.6 6639.9 6668.9 6670.5 6686.7 6386.6 6452.6 6474.7 6478.9 6487.3 6455.3 6538.5 6567.9 6573.3 6574.6 6391.9 6426.3 6427.6 6508.5 6518.5 6422.3 6524.1 6549.5 6635.2 6668.1 6153.8 6254.8 6293.2 6307.8 6314.5 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | [#1] ext.html Cycles:180 Average:36804.58 Median:34460.81 stddev:52398.08 (152.1%) stddev-sans-first:52475.55 19:49:35 INFO - PID 3866 | Values: 858.5 884.7 907.8 910.7 911.5 38750.6 40520.8 40617.8 40634.2 40719.6 37830.6 38020.6 38025.2 38149.6 38196.6 7083.5 7186.8 7189.1 7198.7 7200.3 7124.5 7234.4 7239.0 7247.0 7249.0 7106.5 7119.8 7749.9 7944.9 7951.0 7730.0 7863.9 7867.2 7875.6 7876.3 7684.5 7783.9 7878.4 7880.4 7906.7 37908.6 38120.4 38160.2 38175.0 38214.6 3462.1 3511.6 3515.4 3517.2 3527.9 31534.2 31757.0 31800.0 31843.5 31874.8 5112.2 5117.4 5140.7 5158.0 5169.9 196486.0 197044.0 197070.0 197436.0 198273.0 47703.8 47961.5 48196.8 48430.0 48575.0 49708.0 49749.0 50133.2 50146.5 50379.5 15315.7 15784.3 15803.9 15809.0 15814.6 12687.9 12775.7 12786.9 12845.2 12869.6 14359.3 14367.4 14466.2 14479.9 14599.9 5855.9 5868.0 5870.5 5874.7 5881.5 998.6 999.1 1004.6 1025.5 1027.2 22599.8 23039.8 23043.9 23062.5 23149.3 1111.0 1113.0 1119.3 1121.5 1123.9 11960.8 12266.4 12270.9 12283.0 12453.5 214616.0 215219.0 215686.0 215708.0 217129.0 50905.5 51505.2 52975.7 53610.5 53631.0 1426.1 1443.6 1446.6 1448.3 1451.3 26066.3 26345.9 26371.6 26520.3 26908.3 35987.5 36007.8 36052.3 36082.5 36107.8 193195.0 193549.0 194275.0 194511.0 194809.0 31834.0 31944.8 32040.5 32086.5 32125.5 39795.8 40598.2 40886.4 41109.2 41142.4 30402.4 30785.2 30858.8 30938.2 31484.0 29925.1 30124.2 30185.2 30631.7 30780.8 32912.0 34132.7 34402.1 34519.5 34739.7 30324.0 30404.4 30651.5 30751.5 31403.5 22585.4 22686.0 23184.0 23268.2 23276.9 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | [#2] jquery.html Cycles:180 Average:34770.35 Median:23218.54 stddev:84224.67 (362.7%) stddev-sans-first:84421.83 19:49:35 INFO - PID 3866 | Values: 583.2 583.7 590.6 600.5 601.8 22042.0 22673.7 22724.9 22737.2 22755.2 23149.3 23287.8 23469.6 24309.0 24872.0 6633.8 6706.3 6786.5 6794.7 6794.9 6391.2 6668.7 6778.9 6784.0 6793.5 6615.7 6639.7 6640.0 6645.7 6648.8 6638.8 6638.9 6649.4 6650.4 6651.3 5849.5 6108.8 6113.8 6125.8 6177.6 29300.6 29859.9 29861.1 29883.4 29910.0 2051.4 2070.4 2074.7 2082.7 2084.6 19086.5 19446.8 19746.7 19809.3 19815.9 2356.3 2388.2 2429.3 2465.7 2468.6 119917.0 127315.0 127845.0 128148.4 136595.3 14720.0 14823.3 14889.1 14906.1 15350.8 23541.6 23553.2 23578.4 23627.8 23848.4 9844.7 9860.6 9878.5 9881.1 9918.4 9064.2 9077.4 9174.1 9196.5 9247.5 8980.8 8989.0 9074.0 9198.6 9198.9 2611.9 2631.0 2666.5 2701.6 2764.6 939.6 981.2 984.2 984.8 984.9 18946.2 18969.4 19448.3 19585.0 19677.9 1008.5 1046.2 1049.2 1050.3 1051.8 10617.9 10776.2 10800.9 10829.6 10876.7 491798.0 494063.0 498180.0 510524.0 522626.0 109185.5 110609.0 111426.0 111792.4 112890.0 1027.5 1080.9 1152.2 1153.9 1200.8 19956.6 20014.8 20044.6 20196.5 20296.3 56935.0 57865.7 58438.7 58915.4 59727.4 68931.0 69202.0 70148.6 71514.3 71991.0 14354.9 14870.6 14884.5 14890.4 14895.0 22314.2 22795.7 22961.8 22988.2 23061.8 18035.5 18118.5 18155.0 18207.6 18429.7 16149.6 16560.7 16760.5 16804.2 16893.1 18414.1 18725.6 18945.3 18947.1 18998.8 14402.6 14430.2 14451.3 14486.4 14528.7 18274.4 18301.1 18370.4 18440.6 18600.8 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | [#3] mootools.html Cycles:180 Average:9576.07 Median:2731.89 stddev:6952.18 (254.5%) stddev-sans-first:6944.03 19:49:35 INFO - PID 3866 | Values: 1323.1 1351.8 1359.4 1372.0 1373.7 14926.2 15581.5 15585.8 15601.0 15608.2 15325.3 15404.2 15467.1 15470.8 15472.6 2718.5 2835.2 2838.4 2840.7 2840.8 2754.8 2771.6 2813.9 2829.5 2838.9 2817.0 2838.4 2839.0 2840.4 2841.2 2677.1 2717.7 2721.5 2725.0 2738.8 2716.5 2745.7 2749.7 2751.1 2751.7 15287.9 15384.0 15411.4 15414.4 15439.7 8132.7 8397.6 8410.7 8416.6 8417.6 5290.5 5468.6 5553.8 5565.8 5578.8 1911.4 1971.8 1985.2 2018.4 2029.5 26921.0 27543.3 28299.3 28329.9 28431.3 6860.0 6870.9 6903.2 7086.4 7092.1 17608.6 17613.0 17613.4 17687.1 17695.2 7838.8 8043.9 8062.6 8066.2 8074.1 7370.5 7392.8 7518.9 7654.0 7656.9 5257.4 5336.4 5404.9 5414.6 5457.0 1507.9 1531.0 1540.3 1554.1 1556.9 902.2 905.3 919.6 928.1 938.9 7783.4 7791.6 7829.4 7854.3 7857.4 718.4 726.9 746.5 758.2 764.4 4850.7 4939.5 4973.7 4991.4 5044.9 21889.9 22040.6 22704.0 22859.3 22976.4 21606.6 22142.7 22272.7 22342.1 22568.4 10685.6 11031.3 11334.7 11544.4 11582.8 8530.0 8814.2 8860.7 8879.0 8899.9 18772.4 19366.1 19728.0 19856.5 19957.5 19434.8 19716.0 19748.9 19889.6 20562.9 11264.2 11535.5 11555.6 11561.5 11562.8 14006.4 14229.9 14398.4 14422.4 14468.3 11492.3 11707.7 11968.3 12050.5 12117.6 10746.1 11060.2 11149.8 11389.4 11572.7 9996.8 10018.2 10040.7 10128.4 10242.9 7009.0 7039.5 7072.0 7117.9 7121.5 7744.7 7832.6 7840.7 7861.8 7888.7 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | [#4] prototype.html Cycles:180 Average:5539.79 Median:6170.01 stddev:1509.30 (24.5%) stddev-sans-first:1465.47 19:49:35 INFO - PID 3866 | Values: 505.4 510.1 529.1 540.8 540.8 6121.1 6167.5 6211.6 6271.9 6333.7 6042.3 6161.3 6172.5 6207.9 6210.0 4907.2 5183.5 5189.5 5215.9 5217.4 5011.5 5021.4 5083.6 5088.6 5094.6 4949.4 4964.5 4997.7 5017.3 5040.5 4989.8 5001.7 5022.7 5039.9 5045.4 4513.5 4537.2 4540.9 4549.6 4563.3 6123.5 6204.7 6242.8 6283.0 6306.5 5671.2 5698.7 5710.9 5711.8 5767.7 6581.9 6608.8 6636.6 6645.7 6659.1 4916.0 4921.9 4927.7 4970.5 4973.7 6799.0 6908.4 6952.2 6954.6 6978.2 5053.8 5061.1 5061.6 5097.2 5100.0 5177.8 5194.9 5198.0 5207.8 5224.9 5687.0 5699.9 5730.4 5746.8 5790.0 6382.0 6420.7 6557.7 6591.5 6650.8 1902.0 1933.5 1946.4 1955.8 1958.1 1231.4 1441.0 1447.7 1452.4 1468.9 5638.9 5665.2 5756.4 5757.4 5809.0 6557.1 6582.3 6639.7 6690.4 6743.9 5726.3 5753.9 5757.0 5784.6 5837.8 3525.9 3535.9 3589.9 3604.5 3608.5 6431.4 6469.9 6546.1 6566.4 6586.9 6698.8 6812.9 6820.9 6856.9 6907.9 6416.0 6449.6 6456.9 6582.1 6588.4 6653.0 6679.0 6698.8 6711.5 6762.0 6707.6 6718.5 6728.9 6806.9 6821.7 6556.8 6599.0 6621.2 6632.2 6673.4 4989.9 5007.2 5073.2 5095.6 5114.7 6429.2 6686.7 6697.7 6720.7 6740.6 6353.4 6361.9 6441.2 6530.4 6616.1 6467.4 6470.7 6518.5 6593.4 6617.7 6391.3 6421.6 6457.7 6520.8 6559.2 6378.5 6449.6 6449.7 6466.5 6555.3 5909.8 6213.3 6266.0 6292.0 6339.3 19:49:35 INFO - PID 3866 | 19:49:35 INFO - PID 3866 | [#5] yui.html Cycles:180 Average:25479.13 Median:20655.59 stddev:35842.90 (173.5%) stddev-sans-first:35895.98 19:49:35 INFO - PID 3866 | Values: 912.3 915.4 926.4 930.2 934.6 19647.4 20277.8 20591.4 20621.3 20652.0 18313.7 18468.6 18527.9 18532.9 18537.9 900.3 903.3 904.8 909.3 910.4 967.2 977.5 980.0 980.3 980.5 999.4 1008.8 1008.8 1019.6 1022.3 1001.8 1001.9 1002.2 1002.5 1005.9 716.9 721.8 731.0 731.3 732.6 20498.2 20659.2 20745.3 20763.8 20766.0 21383.5 21798.3 22742.8 22745.9 22850.5 17960.0 17980.8 18130.7 18143.0 18307.6 3776.2 3776.8 3780.2 3803.2 3805.6 109344.0 138841.3 140753.0 141443.0 144063.0 18230.3 18363.2 18407.0 18407.7 18513.9 31861.8 32157.4 32165.9 32236.5 32322.7 9200.8 9339.2 9404.4 9436.6 9472.0 4453.5 4511.6 4528.3 4531.2 4543.4 4928.4 5423.3 5517.1 5542.7 5572.3 1102.6 1115.5 1125.4 1129.1 1130.1 672.8 677.4 685.8 690.4 692.3 11860.6 11946.9 12261.0 12351.9 13031.7 659.3 672.1 672.5 680.5 687.3 5708.8 5911.9 5920.4 5972.8 6043.2 127582.0 127647.4 130353.0 130545.3 134171.0 106506.0 109191.9 113019.0 113038.0 118211.4 96179.5 97492.0 98038.0 99055.5 102757.5 12973.5 13226.3 13337.5 13416.1 13463.9 43378.8 43676.6 44180.6 44880.6 45508.5 59677.0 60124.0 60168.0 61304.7 61552.0 18750.6 19011.9 19038.0 19064.7 19245.7 21037.6 21038.4 21135.8 21149.0 21328.3 17870.6 18299.6 18534.4 18599.5 18673.2 18993.9 19762.6 19939.0 20081.0 20112.1 17792.0 18281.9 18311.5 18350.4 18457.3 13172.1 13198.6 13213.7 13284.0 13376.0 13649.1 13820.0 13840.2 13929.2 14001.2 19:49:35 INFO - PID 3866 | -------- Summary: end -------- 19:49:35 INFO - PID 3866 | 19:49:36 INFO - TEST-INFO | 3866: exit 0 19:49:36 INFO - TEST-OK | dromaeo_css | took 1110266ms 19:49:36 INFO - TEST-START | kraken 19:49:36 INFO - Initialising browser for kraken test... 19:49:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35748/getInfo.html -profile /tmp/tmpxN9ySN/profile 19:49:36 INFO - TEST-INFO | started process 4225 (/builds/slave/test/build/application/firefox/firefox http://localhost:35748/getInfo.html) 19:49:42 INFO - TEST-INFO | 4225: exit 0 19:49:42 INFO - Browser initialized. 19:49:42 INFO - Running cycle 1/1 for kraken test... 19:49:42 INFO - Using env: {'DISPLAY': ':0', 19:49:42 INFO - 'HOME': '/home/cltbld', 19:49:42 INFO - 'JSGC_DISABLE_POISONING': '1', 19:49:42 INFO - 'LANG': 'en_US.UTF-8', 19:49:42 INFO - 'LANGUAGE': 'en_US:en', 19:49:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:49:42 INFO - 'LOGNAME': 'cltbld', 19:49:42 INFO - 'MAIL': '/var/mail/cltbld', 19:49:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:49:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:49:42 INFO - 'MOZ_CRASHREPORTER': '1', 19:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:49:42 INFO - 'MOZ_NO_REMOTE': '1', 19:49:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:42 INFO - 'NO_EM_RESTART': '1', 19:49:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:42 INFO - 'PWD': '/builds/slave/test', 19:49:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:49:42 INFO - 'RUST_BACKTRACE': 'full', 19:49:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:49:42 INFO - 'SHELL': '/bin/bash', 19:49:42 INFO - 'SHLVL': '1', 19:49:42 INFO - 'STYLO_FORCE_DISABLED': '1', 19:49:42 INFO - 'TERM': 'linux', 19:49:42 INFO - 'TMOUT': '86400', 19:49:42 INFO - 'USER': 'cltbld', 19:49:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857', 19:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:42 INFO - '_': '/tools/buildbot/bin/python'} 19:49:42 INFO - TEST-INFO | started process 4461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxN9ySN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:43 INFO - PID 4461 | 19:49:43 INFO - PID 4461 | (/builds/slave/test/build/application/firefox/firefox:4510): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:49:43 INFO - PID 4461 | 19:49:53 INFO - PID 4461 | RSS: Main: 150831104 19:49:53 INFO - PID 4461 | 19:49:56 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35748/tests/kraken/driver.html?testName=audio-beat-detection) 19:49:57 INFO - PID 4461 | RSS: Main: 157892608 19:49:57 INFO - PID 4461 | 19:49:59 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35748/tests/kraken/driver.html?testName=audio-dft) 19:50:00 INFO - PID 4461 | RSS: Main: 158904320 19:50:00 INFO - PID 4461 | 19:50:03 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35748/tests/kraken/driver.html?testName=audio-fft) 19:50:03 INFO - PID 4461 | RSS: Main: 154447872 19:50:03 INFO - PID 4461 | 19:50:05 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35748/tests/kraken/driver.html?testName=audio-oscillator) 19:50:06 INFO - PID 4461 | RSS: Main: 155037696 19:50:06 INFO - PID 4461 | 19:50:08 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:09 INFO - PID 4461 | RSS: Main: 155410432 19:50:09 INFO - PID 4461 | 19:50:12 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35748/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:13 INFO - PID 4461 | RSS: Main: 158138368 19:50:13 INFO - PID 4461 | 19:50:16 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35748/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:17 INFO - PID 4461 | RSS: Main: 158048256 19:50:17 INFO - PID 4461 | 19:50:20 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35748/tests/kraken/driver.html?testName=json-parse-financial) 19:50:20 INFO - PID 4461 | RSS: Main: 157896704 19:50:20 INFO - PID 4461 | 19:50:22 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:23 INFO - PID 4461 | RSS: Main: 158011392 19:50:23 INFO - PID 4461 | 19:50:24 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:25 INFO - PID 4461 | RSS: Main: 157937664 19:50:25 INFO - PID 4461 | 19:50:28 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:50:28 INFO - PID 4461 | RSS: Main: 155312128 19:50:28 INFO - PID 4461 | 19:50:31 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:50:32 INFO - PID 4461 | RSS: Main: 155705344 19:50:32 INFO - PID 4461 | 19:50:34 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:50:35 INFO - PID 4461 | RSS: Main: 155746304 19:50:35 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | Cycle 1(1): loaded http://localhost:35748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35748/tests/kraken/driver.html?testName=ai-astar) 19:50:37 INFO - PID 4461 | RSS: Main: 156934144 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | __start_tp_report 19:50:37 INFO - PID 4461 | _x_x_mozilla_page_load 19:50:37 INFO - PID 4461 | _x_x_mozilla_page_load_details 19:50:37 INFO - PID 4461 | |i|pagename|runs| 19:50:37 INFO - PID 4461 | |0;ai-astar;107;107;107;107;107;102;111;108;109;107 19:50:37 INFO - PID 4461 | |1;audio-beat-detection;118;117;121;117;116;119;116;114;141;116 19:50:37 INFO - PID 4461 | |2;audio-dft;166;162;162;161;162;161;165;162;165;164 19:50:37 INFO - PID 4461 | |3;audio-fft;77;77;73;76;75;74;75;75;75;74 19:50:37 INFO - PID 4461 | |4;audio-oscillator;80;81;79;79;79;79;81;79;80;79 19:50:37 INFO - PID 4461 | |5;imaging-gaussian-blur;110;113;114;110;114;114;114;118;115;116 19:50:37 INFO - PID 4461 | |6;imaging-darkroom;156;147;147;149;147;147;148;149;149;149 19:50:37 INFO - PID 4461 | |7;imaging-desaturate;99;96;96;94;94;95;96;95;96;95 19:50:37 INFO - PID 4461 | |8;json-parse-financial;53;53;51;52;48;50;50;50;54;52 19:50:37 INFO - PID 4461 | |9;json-stringify-tinderbox;36;37;37;37;38;36;37;37;37;37 19:50:37 INFO - PID 4461 | |10;stanford-crypto-aes;71;74;71;74;72;71;73;72;71;75 19:50:37 INFO - PID 4461 | |11;stanford-crypto-ccm;113;110;107;119;114;122;112;111;113;116 19:50:37 INFO - PID 4461 | |12;stanford-crypto-pbkdf2;158;160;163;170;169;161;170;165;161;160 19:50:37 INFO - PID 4461 | |13;stanford-crypto-sha256-iterative;69;64;64;64;64;66;73;63;62;67 19:50:37 INFO - PID 4461 | __end_tp_report 19:50:37 INFO - PID 4461 | __start_cc_report 19:50:37 INFO - PID 4461 | _x_x_mozilla_cycle_collect,742 19:50:37 INFO - PID 4461 | __end_cc_report 19:50:37 INFO - PID 4461 | __startTimestamp1506567037588__endTimestamp 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | ------- Summary: start ------- 19:50:37 INFO - PID 4461 | Number of tests: 14 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#0] ai-astar Cycles:10 Average:107.20 Median:107.00 stddev:2.25 (2.1%) stddev-sans-first:2.39 19:50:37 INFO - PID 4461 | Values: 107.0 107.0 107.0 107.0 107.0 102.0 111.0 108.0 109.0 107.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:117.50 stddev:7.79 (6.6%) stddev-sans-first:8.25 19:50:37 INFO - PID 4461 | Values: 118.0 117.0 121.0 117.0 116.0 119.0 116.0 114.0 141.0 116.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.83 (1.1%) stddev-sans-first:1.58 19:50:37 INFO - PID 4461 | Values: 166.0 162.0 162.0 161.0 162.0 161.0 165.0 162.0 165.0 164.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:1.29 (1.7%) stddev-sans-first:1.17 19:50:37 INFO - PID 4461 | Values: 77.0 77.0 73.0 76.0 75.0 74.0 75.0 75.0 75.0 74.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 19:50:37 INFO - PID 4461 | Values: 80.0 81.0 79.0 79.0 79.0 79.0 81.0 79.0 80.0 79.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:2.44 (2.1%) stddev-sans-first:2.17 19:50:37 INFO - PID 4461 | Values: 110.0 113.0 114.0 110.0 114.0 114.0 114.0 118.0 115.0 116.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:2.70 (1.8%) stddev-sans-first:1.00 19:50:37 INFO - PID 4461 | Values: 156.0 147.0 147.0 149.0 147.0 147.0 148.0 149.0 149.0 149.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:0.83 19:50:37 INFO - PID 4461 | Values: 99.0 96.0 96.0 94.0 94.0 95.0 96.0 95.0 96.0 95.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:1.83 (3.5%) stddev-sans-first:1.83 19:50:37 INFO - PID 4461 | Values: 53.0 53.0 51.0 52.0 48.0 50.0 50.0 50.0 54.0 52.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#9] json-stringify-tinderbox Cycles:10 Average:36.90 Median:37.00 stddev:0.57 (1.5%) stddev-sans-first:0.50 19:50:37 INFO - PID 4461 | Values: 36.0 37.0 37.0 37.0 38.0 36.0 37.0 37.0 37.0 37.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:1.51 (2.1%) stddev-sans-first:1.51 19:50:37 INFO - PID 4461 | Values: 71.0 74.0 71.0 74.0 72.0 71.0 73.0 72.0 71.0 75.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:113.50 stddev:4.37 (3.9%) stddev-sans-first:4.63 19:50:37 INFO - PID 4461 | Values: 113.0 110.0 107.0 119.0 114.0 122.0 112.0 111.0 113.0 116.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:4.52 (2.8%) stddev-sans-first:4.30 19:50:37 INFO - PID 4461 | Values: 158.0 160.0 163.0 170.0 169.0 161.0 170.0 165.0 161.0 160.0 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:3.31 (5.1%) stddev-sans-first:3.27 19:50:37 INFO - PID 4461 | Values: 69.0 64.0 64.0 64.0 64.0 66.0 73.0 63.0 62.0 67.0 19:50:37 INFO - PID 4461 | -------- Summary: end -------- 19:50:37 INFO - PID 4461 | 19:50:37 INFO - PID 4461 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:50:38 INFO - TEST-INFO | 4461: exit 0 19:50:38 INFO - TEST-OK | kraken | took 61615ms 19:50:38 INFO - SUITE-END | took 1171s 19:50:38 INFO - Completed test suite (00:19:32) 19:50:38 INFO - javascript benchmark 19:50:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8586.94948938931, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.1400121967067, 3210.4381733196683, 3219.9696097248875, 3220.0500852248583, 3238.821864797437, 6172.845678858031, 6221.3156552779155, 6245.968770156149, 6278.152449419327, 6363.268224154218, 6119.3574674659185, 6121.296050954131, 6122.540809439288, 6152.630842149474, 6165.044418115188, 5653.180288858123, 5658.632188907728, 5670.886582268373, 5719.342275638292, 5830.242068531106, 5757.136429535562, 5809.912851307234, 5820.330661973885, 5842.853928651775, 5914.556408269397, 5782.421757824205, 5797.536197104221, 5873.618214816044, 5876.588638795286, 5877.353491115974, 5613.859653508695, 5698.059820129673, 5756.424357564252, 5773.740181691834, 5824.737886795105, 5718.513926316268, 5737.053386191274, 5788.768449262025, 5790.623609465371, 5798.768049278024, 6210.813675589694, 6220.129181914535, 6254.312025677172, 6263.0, 6269.028300613412, 6473.805785826433, 6619.073329733841, 6664.233613134503, 6738.966305168492, 6742.59544427331, 6703.095082163943, 6806.081179040815, 6806.149231346082, 6810.28492008337, 6815.761448349284, 6180.103884936659, 6194.194754681907, 6280.717367718464, 6281.183446151971, 6286.994080947026, 6781.355771201728, 6847.589144651237, 6847.897281540781, 6904.206016308089, 6936.514443988873, 6344.080108384258, 6424.935750642434, 6468.967655161694, 6519.739210431624, 6535.738570457129, 6635.601863888182, 6652.83367915806, 6664.366885145903, 6664.600123992576, 6694.029365742038, 6450.838729031718, 6611.107500487469, 6665.6000639960785, 6667.833304167338, 6710.630915299607, 6644.900326495106, 6663.0, 6738.966305168541, 6745.8650826983185, 6748.156480439945, 4803.447603525569, 4849.224124140121, 4860.4896485869185, 4933.851984440473, 4947.802087916443, 4305.956940430556, 4354.346847972829, 4392.780360981938, 4410.029793445437, 4414.580614841585, 5721.056025755704, 5728.026235539968, 5796.942030579725, 5798.333191682926, 5813.82558523245, 6632.668366581652, 6682.966585167043, 6729.25978142404, 6786.4570834333135, 6810.353016463428, 5675.347335056439, 5753.964286428483, 5758.769649213985, 5769.653820770767, 5807.5063619591965, 5653.0, 5714.371419143891, 5716.685582293014, 5786.07422812348, 5791.218185544982, 6320.209973753281, 6334.936650633527, 6337.588056776295, 6347.809565713036, 6360.173177486897, 6508.967455162694, 6511.218653761484, 6660.766873159416, 6752.020956961115, 6815.318468153145, 6489.805305840832, 6500.28496865335, 6566.80299591013, 6593.637349945607, 6606.47148228131, 6568.540202185993, 6591.6374599397495, 6669.433098186709, 6669.599824010575, 6681.832954176184, 6574.605523668595, 6639.933600663931, 6668.933310666831, 6670.466362690876, 6686.732530698718, 6386.648734319471, 6452.580582262138, 6474.676266186766, 6478.902816457663, 6487.3188315226225, 6455.289918108911, 6538.542302039002, 6567.9014814778775, 6573.3098024706715, 6574.605523668595, 6391.936080639134, 6426.29310775805, 6427.55007149495, 6508.511861610304, 6518.543701940818, 6422.293547709654, 6524.086627872007, 6549.4760419167305, 6635.170603674541, 6668.099806526056, 6153.784617538544, 6254.781082662267, 6293.213348331458, 6307.779227727007, 6314.494840412848], "value": 6065.43140803836, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.4634603372892, 884.6903583745689, 907.7912080221547, 910.7267819654111, 911.503230739247, 38750.61249387505, 40520.797396013055, 40617.79691101548, 40634.187316253694, 40719.59280407199, 37830.621693783054, 38020.619793802056, 38025.239495210146, 38149.618503814956, 38196.61803381972, 7083.539569927964, 7186.820329491752, 7189.065421495198, 7198.7480438184675, 7200.279972002811, 7124.501284910032, 7234.421246300283, 7239.0, 7246.963765181166, 7248.963755181217, 7106.467014973872, 7119.750808721696, 7749.9225007749765, 7944.920550794476, 7951.0, 7729.961350193241, 7863.921360786376, 7867.213278672144, 7875.566843823587, 7876.251756083163, 7684.500507467053, 7783.922160778433, 7878.36973042161, 7880.408969327266, 7906.723264685708, 37908.620913790786, 38120.42819357712, 38160.23679526394, 38175.0, 38214.617853821386, 3462.117160124152, 3511.6488351164935, 3515.367233897897, 3517.2437925846066, 3527.8588856445713, 31534.211644708837, 31757.0, 31800.045998620077, 31843.52234716481, 31874.840625796955, 5112.233165025239, 5117.385913690381, 5140.7172605506685, 5158.0, 5169.922451163236, 196486.0, 197044.0, 197070.0, 197436.0, 198273.00863495734, 47703.76148119307, 47961.5203847964, 48196.7590162047, 48430.0, 48575.0, 49708.0, 49749.0, 50133.24800128001, 50146.498535014915, 50379.49620503748, 15315.693686126215, 15784.289706963214, 15803.920980395025, 15809.0, 15814.60463488422, 12687.873121268854, 12775.680607984874, 12786.872131278567, 12845.165064270792, 12869.613911582668, 14359.282035898163, 14367.353469093707, 14466.204358760158, 14479.855201448061, 14599.854001460062, 5855.912161317584, 5868.0, 5870.501007414332, 5874.707564335839, 5881.529477641779, 998.5855869814092, 999.0558921818812, 1004.6182450668845, 1025.4975062219607, 1027.244974943416, 22599.774002260096, 23039.7696023041, 23043.88478057599, 23062.53874922492, 23149.3055208344, 1110.9722256943642, 1112.9721756956142, 1119.3228097001197, 1121.4673030310537, 1123.9157063220127, 11960.820587691192, 12266.448009839578, 12270.877291227152, 12283.0, 12453.501859925682, 214616.0, 215219.0, 215686.0, 215708.0, 217129.0, 50905.490945090074, 51505.22742158871, 52975.73512132492, 53610.463895361325, 53631.0, 1426.0730525158522, 1443.6246575890134, 1446.5732608880405, 1448.3482432905234, 1451.3468938977292, 26066.34834129162, 26345.868270658524, 26371.60442593401, 26520.336991575365, 26908.327291817863, 35987.46018809772, 36007.81996090003, 36052.27895442024, 36082.45876311805, 36107.81946090253, 193195.0, 193549.0, 194275.0, 194511.0, 194809.0, 31834.044978650676, 31944.840275798473, 32040.5193922096, 32086.518702219953, 32125.518117228727, 39795.80102099471, 40598.1880362397, 40886.38670420006, 41109.177816442905, 41142.382864257655, 30402.391952161277, 30785.230369240948, 30858.845705771328, 30938.226544336572, 31484.0, 29925.102246932627, 30124.24689382783, 30185.245368865075, 30631.693683062884, 30780.846095770274, 32912.0, 34132.658673412945, 34402.139946501535, 34519.4822077664, 34739.652603473645, 30324.0, 30404.391912162075, 30651.54022689706, 30751.538726918665, 31403.528947065355, 22585.435364116027, 22686.0, 23184.0, 23268.185613503447, 23276.883615581814], "value": 16916.60527639405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.1689841975184, 583.716897304807, 590.6013440927373, 600.5165841497594, 601.8104297146399, 22042.008109635066, 22673.659895101588, 22724.88637556814, 22737.204197853058, 22755.203567875127, 23149.30552083436, 23287.767122328773, 23469.647955280685, 24309.027638894422, 24872.0, 6633.7678181263545, 6706.26231114577, 6786.524943253974, 6794.694238759243, 6794.898076528856, 6391.169148010776, 6668.733250669968, 6778.864422711543, 6783.966080169592, 6793.490488213404, 6615.735370585171, 6639.73441062357, 6640.0, 6645.667716614174, 6648.800535983904, 6638.767643132515, 6638.900416493757, 6649.434798042173, 6650.401463868251, 6651.268360480319, 5849.473547380756, 6108.755649774003, 6113.847153821145, 6125.846853828645, 6177.567570270083, 29300.56049159243, 29859.850700746574, 29861.10416687503, 29883.402331953457, 29910.0, 2051.3743308290964, 2070.3995841206033, 2074.6887966804948, 2082.666773316277, 2084.6247675418417, 19086.52283692905, 19446.80553194464, 19746.70379944302, 19809.306674266332, 19815.90092049545, 2356.2931120663734, 2388.2391787532456, 2429.319790458657, 2465.7287698353166, 2468.5556599812026, 119917.0, 127315.0, 127845.0, 128148.35925820404, 136595.31702341523, 14720.0, 14823.258837058103, 14889.106653600818, 14906.105633662015, 15350.846491534941, 23541.646875296883, 23553.175638852557, 23578.410539736302, 23627.7637223629, 23848.40378990539, 9844.655437059668, 9860.605575776888, 9878.4566848824, 9881.110700037032, 9918.355306905029, 9064.229540489001, 9077.364584479023, 9174.082591740906, 9196.494192819458, 9247.491387973727, 8980.775480613036, 8989.01120876703, 9073.95463022694, 9198.586063627154, 9198.896132464148, 2611.8955241790495, 2630.9605355919675, 2666.4933662604044, 2701.6217729517884, 2764.640596722413, 939.5959737313021, 981.1954197557934, 984.1831280037552, 984.8276551603441, 984.9015098490094, 18946.242150313832, 18969.430917072234, 19448.319308824124, 19585.0, 19677.901610491856, 1008.4604736465956, 1046.2467023743045, 1049.2130901823632, 1050.2565740870118, 1051.779126383468, 10617.940796270559, 10776.245662803529, 10800.891991080145, 10829.566817327219, 10876.74917384511, 491798.0, 494063.0, 498180.0, 510524.0, 522626.0, 109185.45407273072, 110609.0, 111426.0, 111792.44103779591, 112890.0, 1027.5427434791595, 1080.8594882665204, 1152.1877076660935, 1153.8615366156116, 1200.7598480303975, 19956.60086798285, 20014.799852001295, 20044.599108017468, 20196.495087622927, 20296.289629862884, 56935.0, 57865.71067144637, 58438.70780646239, 58915.41084589099, 59727.402725972184, 68931.0, 69202.0, 70148.64925675339, 71514.28485715076, 71991.0, 14354.85645143577, 14870.628234293796, 14884.479043233436, 14890.404383824525, 14895.0, 22314.21900233484, 22795.65806512937, 22961.770382295963, 22988.195413161127, 23061.769382305964, 18035.458936231935, 18118.45644630663, 18155.0, 18207.635847283243, 18429.723554146967, 16149.596260093122, 16560.66878662396, 16760.497185084467, 16804.159792010105, 16893.070881101656, 18414.079296034877, 18725.625487489902, 18945.33691320797, 18947.0526473673, 18998.810011899703, 14402.639934001734, 14430.206338651475, 14451.349689264218, 14486.420543178156, 14528.709425811636, 18274.36039738656, 18301.084945752395, 18370.357037504156, 18440.631187375908, 18600.813991859908], "value": 11960.189059329634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.0738483061857, 1351.8310211223593, 1359.3543067043163, 1371.9931400342996, 1373.7183877305154, 14926.179060151688, 15581.532554023383, 15585.766213506793, 15601.0, 15608.21958902056, 15325.310361033753, 15404.152771597557, 15467.149306788122, 15470.756740272654, 15472.613184670388, 2718.497078040559, 2835.1919702884684, 2838.4181242845166, 2840.7443330100286, 2840.758535524483, 2754.752072313491, 2771.5704065869722, 2813.9015134470296, 2829.4624021435966, 2838.858057097147, 2816.957745633817, 2838.3897462045657, 2839.0, 2840.4177143685497, 2841.176058942904, 2677.116551538007, 2717.7418145276265, 2721.4557088582264, 2724.9591256131175, 2738.821976571536, 2716.4702882937836, 2745.6567929008875, 2749.6837863645737, 2751.0783887397747, 2751.683556391021, 15287.853410994108, 15384.0, 15411.3835446582, 15414.383424663, 15439.691206175927, 8132.715354962548, 8397.580120993987, 8410.747677569683, 8416.579171041423, 8417.579121043984, 5290.497402746733, 5468.562514998791, 5553.750081246313, 5565.833025009256, 5578.832635020955, 1911.4074636862617, 1971.753530808649, 1985.2158397432934, 2018.4348382452936, 2029.4824819671037, 26921.0, 27543.31141721453, 28299.292517687016, 28329.858350708113, 28431.289217769514, 6860.0, 6870.862582748417, 6903.205166656706, 7086.362227399559, 7092.078029856189, 17608.55978600545, 17613.0, 17613.38353157659, 17687.115644217996, 17695.203715832817, 7838.843223135619, 8043.879341809878, 8062.596870156469, 8066.23370779775, 8074.111847696749, 7370.48406611532, 7392.815179620553, 7518.887216691644, 7654.0, 7656.885146722803, 5257.421683614799, 5336.439673834269, 5404.891902162013, 5414.593905457106, 5456.972715136479, 1507.9246037698072, 1530.9846901531064, 1540.345353224875, 1554.1452201289471, 1556.8910176287777, 902.228594551662, 905.3210092430677, 919.558611866308, 928.0951072704195, 938.863864739609, 7783.377329813601, 7791.649375778104, 7829.3736501079775, 7854.253845884632, 7857.410694197958, 718.4467959671024, 726.9345758881726, 746.5371469688719, 758.1622307350409, 764.4152223548989, 4850.708957462563, 4939.53074457926, 4973.676711013845, 4991.425986011655, 5044.924326135111, 21889.890550547465, 22040.559188816133, 22703.978320975595, 22859.31422057341, 22976.425589360064, 21606.567868642538, 22142.667859982113, 22272.66591001136, 22342.106315747187, 22568.435789105075, 10685.626003089854, 11031.338119712844, 11334.659960201207, 11544.365059921785, 11582.841715828517, 8529.95735021321, 8814.162654547808, 8860.689875854314, 8878.955605221932, 8899.911000889908, 18772.436826895217, 19366.12852421616, 19728.0, 19856.503587409854, 19957.501062473555, 19434.8056519433, 19716.0, 19748.901255494206, 19889.60220795605, 20562.897185513975, 11264.211505194886, 11535.480903359201, 11555.595554155565, 11561.537538498365, 11562.826557601475, 14006.439742410597, 14229.857701423267, 14398.42406303736, 14422.350994205077, 14468.27658617044, 11492.310461372344, 11707.707307317385, 11968.281903085843, 12050.51797928073, 12117.636470905887, 10746.086582640562, 11060.225784195029, 11149.83275250888, 11389.373584452604, 11572.652820415064, 9996.750081248027, 10018.248631352531, 10040.69877903664, 10128.392296462236, 10242.948785256027, 7008.9649551753955, 7039.507234493536, 7071.964640176766, 7117.928820711727, 7121.537100088478, 7744.728934487266, 7832.647530861239, 7840.686372545034, 7861.8034549134445, 7888.68445262206], "value": 6770.708745276631, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.3657659637157, 510.130227961326, 529.0741202894934, 540.8053100883682, 540.8458589302048, 6121.143039974407, 6167.537434692399, 6211.627302361861, 6271.937280627192, 6333.683315834213, 6042.305134909487, 6161.291451483081, 6172.475339596129, 6207.906881396782, 6210.0, 4907.214845624683, 5183.50756678115, 5189.532942035216, 5215.869603259911, 5217.37391513019, 5011.523905228997, 5021.422536408305, 5083.618728595352, 5088.592912566985, 5094.566961808251, 4949.430815456232, 4964.503549645043, 4997.675151115166, 5017.347744793172, 5040.546350828425, 4989.825356112518, 5001.749912504397, 5022.748862556894, 5039.874003149932, 5045.369328833895, 4513.526079761644, 4537.228671125917, 4540.8864778380475, 4549.567791059844, 4563.269876819693, 6123.540734444934, 6204.689765511752, 6242.843928901769, 6283.0, 6306.49548036156, 5671.234383358235, 5698.6865722385255, 5710.942890571083, 5711.7715291388295, 5767.740451679642, 6581.901271480931, 6608.834779130512, 6636.601803891782, 6645.734170633169, 6659.101021362151, 4916.0, 4921.926171107436, 4927.704337739747, 4970.502949705036, 4973.701577905337, 6798.966005169992, 6908.412784913288, 6952.200496942815, 6954.582725036514, 6978.162620485524, 5053.772580233898, 5061.089003979319, 5061.645684802029, 5097.158968770112, 5100.0, 5177.792888284426, 5194.92207616886, 5197.974010129925, 5207.791688332424, 5224.947750522522, 5686.97156514223, 5699.914501282484, 5730.3785964666895, 5746.770129194785, 5789.9710501447225, 6382.0, 6420.678966051679, 6557.704903279364, 6591.505637077238, 6650.83372915681, 1901.9809801902081, 1933.5166208447888, 1946.4355336952408, 1955.8435325173953, 1958.1384190955935, 1231.445849367788, 1441.0345068803717, 1447.7321695486369, 1452.4408102880468, 1468.8751456126136, 5638.887222255532, 5665.1502274658305, 5756.416985328984, 5757.366689664133, 5808.970955145197, 6557.114789503356, 6582.341765823379, 6639.734410623521, 6690.364415380531, 6743.898841517381, 5726.312842458931, 5753.88492230153, 5756.9775867669805, 5784.623999440023, 5837.824865254049, 3525.8765943191866, 3535.8939231823088, 3589.8743543975834, 3604.513390692223, 3608.45873119029, 6431.356864313625, 6469.8706025880165, 6546.0835483032415, 6566.4418524425, 6586.868262634721, 6698.83252918681, 6812.931870681329, 6820.93179068203, 6856.862862742817, 6907.861842763116, 6415.957946493679, 6449.580777249557, 6456.935430645727, 6582.144321238208, 6588.4070433660245, 6653.006147233667, 6678.966605166943, 6698.765543205965, 6711.4966377520905, 6762.0, 6707.597544147172, 6718.529702920749, 6728.899066513908, 6806.8638627228165, 6821.727130914906, 6556.803295901131, 6598.967005164944, 6621.172353455818, 6632.2372927114, 6673.432758215412, 4989.850304490871, 5007.223880298559, 5073.18828987375, 5095.643304968765, 5114.74426278692, 6429.164208652845, 6686.732530698718, 6697.698603562754, 6720.663966801738, 6740.62926539045, 6353.428191462605, 6361.93638063632, 6441.1626488556185, 6530.412262896362, 6616.073749675145, 6467.385598368148, 6470.729318649669, 6518.478521718346, 6593.3736295051895, 6617.735290588323, 6391.265004524539, 6421.614703117641, 6457.6771161442675, 6520.836979075561, 6559.245686746085, 6378.489720822416, 6449.6458792541325, 6449.677516124081, 6466.515011374072, 6555.311692272243, 5909.762132822532, 6213.347598502092, 6266.0, 6291.993281075006, 6339.270983836734], "value": 5112.579678105525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.2747415804439, 915.4461550761789, 926.4024704065882, 930.1675000874218, 934.593451848446, 19647.41057768266, 20277.797222027777, 20591.38225853223, 20621.27825526107, 20652.0, 18313.7252941206, 18468.630627387476, 18527.907360463214, 18532.907335463304, 18537.907310463463, 900.3067637918798, 903.3225081189108, 904.7828521154909, 909.2544113826665, 910.3627460777466, 967.1682353176262, 977.5307852230933, 979.9706008819746, 980.3186785184299, 980.4999450280372, 999.3953658036855, 1008.7831116309992, 1008.8083264179819, 1019.6227395863503, 1022.269077609509, 1001.7695929936083, 1001.8897921228659, 1002.2433063037397, 1002.5488530161457, 1005.8994100589919, 716.8888822232562, 721.7762493626992, 730.989035164473, 731.294300999538, 732.560463721768, 20498.18007279707, 20659.17363305466, 20745.273915412887, 20763.792362076336, 20765.961701914843, 21383.465413364636, 21798.346049618536, 22742.772572274396, 22745.886270568706, 22850.542989140125, 17960.0, 17980.820191798044, 18130.728039079426, 18143.002134882707, 18307.63384732311, 3776.2447510497736, 3776.8111594420443, 3780.1872597391693, 3803.220339830356, 3805.56236032857, 109344.0, 138841.30579347038, 140753.0, 141443.0, 144063.0, 18230.27078916855, 18363.17365718519, 18407.0, 18407.72388414175, 18513.90743046276, 31861.840690796398, 32157.35685286328, 32165.87419440355, 32236.516452253236, 32322.676773231968, 9200.815983680423, 9339.159475647224, 9404.38871473352, 9436.575354109082, 9471.952640236892, 4453.532379100147, 4511.571400716926, 4528.275475923902, 4531.184386810406, 4543.432070991126, 4928.408590969107, 5423.3491980962535, 5517.089680202802, 5542.667439953535, 5572.3034620672415, 1102.6030628973563, 1115.520326259716, 1125.352922069813, 1129.0910816792398, 1130.1072152999038, 672.7510820996263, 677.376813331736, 685.7736946807541, 690.4062506244626, 692.2834865913856, 11860.644180674593, 11946.88053119475, 12261.0, 12351.876481235253, 13031.739365212643, 659.3241927024837, 672.1027428383065, 672.5023482622823, 680.4556354916048, 687.3023880760932, 5708.771649134072, 5911.852203694856, 5920.437558431942, 5972.761089556369, 6043.214382130383, 127582.0, 127647.3617631906, 130353.0, 130545.34727326492, 134171.0, 106506.0, 109191.90808091976, 113019.0, 113038.0, 118211.40894295473, 96179.51910240404, 97491.99999999859, 98038.0, 99055.50472247737, 102757.48621256846, 12973.481060757464, 13226.272555009567, 13337.53318633843, 13416.060875738605, 13463.865361346652, 43378.783106084265, 43676.56323436725, 44180.558194417645, 44880.551194487634, 45508.544914551756, 59677.0, 60124.0, 60168.0, 61304.69347653233, 61552.0, 18750.624987500447, 19011.904940475208, 19038.048097595343, 19064.714029289848, 19245.711314330016, 21037.57924841525, 21038.368848934555, 21135.78864211338, 21149.0, 21328.253511127037, 17870.5532361692, 18299.634007319513, 18534.351297704514, 18599.53501162482, 18673.15970781291, 18993.905030474758, 19762.604747904676, 19939.0, 20081.0, 20112.094955726734, 17792.0, 18281.908590456962, 18311.54221144482, 18350.449486515427, 18457.261709531467, 13172.143810652276, 13198.60404187876, 13213.735725285249, 13284.0, 13376.0, 13649.11280766747, 13820.0, 13840.169589824643, 13929.233892135624, 14001.159930404208], "value": 9436.71930580681, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1406.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 107.0, 107.0, 102.0, 111.0, 108.0, 109.0, 107.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 121.0, 117.0, 116.0, 119.0, 116.0, 114.0, 141.0, 116.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 161.0, 162.0, 161.0, 165.0, 162.0, 165.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 73.0, 76.0, 75.0, 74.0, 75.0, 75.0, 75.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 79.0, 79.0, 79.0, 81.0, 79.0, 80.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 110.0, 114.0, 114.0, 114.0, 118.0, 115.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 147.0, 147.0, 149.0, 147.0, 147.0, 148.0, 149.0, 149.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 96.0, 94.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 51.0, 52.0, 48.0, 50.0, 50.0, 50.0, 54.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 37.0, 38.0, 36.0, 37.0, 37.0, 37.0, 37.0], "value": 36.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 71.0, 74.0, 72.0, 71.0, 73.0, 72.0, 71.0, 75.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 107.0, 119.0, 114.0, 122.0, 112.0, 111.0, 113.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 163.0, 170.0, 169.0, 161.0, 170.0, 165.0, 161.0, 160.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 64.0, 64.0, 64.0, 66.0, 73.0, 63.0, 62.0, 67.0], "value": 65.6, "unit": "score"}]}]} 19:50:38 INFO - Return code: 0 19:50:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:50:38 INFO - # TBPL SUCCESS # 19:50:38 INFO - Running post-action listener: _package_coverage_data 19:50:38 INFO - Running post-action listener: _resource_record_post_action 19:50:38 INFO - [mozharness: 2017-09-28 02:50:38.889061Z] Finished run-tests step (success) 19:50:38 INFO - Running post-run listener: _resource_record_post_run 19:50:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9052160; Write bytes: 460746752; Read time: 2648; Write time: 386508 19:50:38 INFO - TinderboxPrint: CPU usage
13.1% 19:50:38 INFO - TinderboxPrint: I/O read bytes / time
9,052,160 / 2,648 19:50:38 INFO - TinderboxPrint: I/O write bytes / time
460,746,752 / 386,508 19:50:38 INFO - TinderboxPrint: CPU idle
8,245.4 (86.8%) 19:50:38 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 19:50:38 INFO - TinderboxPrint: Swap in / out
0 / 0 19:50:38 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 78524416; Read time: 84; Write time: 44532 19:50:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:50:38 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 6553600; Write bytes: 323248128; Read time: 1736; Write time: 260440 19:50:39 INFO - Running post-run listener: _upload_blobber_files 19:50:39 INFO - Blob upload gear active. 19:50:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:50:39 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 19:50:39 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'] 19:50:39 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 19:50:39 INFO - (blobuploader) - INFO - Open directory for files ... 19:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 19:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 19:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:40 INFO - (blobuploader) - INFO - Done attempting. 19:50:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 19:50:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 19:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:41 INFO - (blobuploader) - INFO - Done attempting. 19:50:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:50:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:50:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:43 INFO - (blobuploader) - INFO - Done attempting. 19:50:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:50:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:50 INFO - (blobuploader) - INFO - Done attempting. 19:50:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:50:50 INFO - Return code: 0 19:50:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:50:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:50:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17b8dfff38a69e029ccb19647ee9f4131c6b3868ca5afdd40352f026c4072d8f20ad27f13a89d5ac0aeed367e699c5f398b076c539de89744f995338fc1cb40f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1869c6605b9d8d6c3084c4e3f238504f2cfaa6efe5d2fa37037fbcfd4b55f49b15335258cb59c87aa8668e90b808269b34d43252c652c319d3453f10854ff347", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c4d9a5e12760483173ff2c0f164800a3be5543e4bf5d814b1175ec18cdb78d6bdcdc86a3a15be29e9db7d00c1795ece8b4d2435f11b8e980a008597c202ef5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a288b1a9ecc1d5a98ba10b4276f6cf691c22399b9b1a2be8c11e4107578498989343422762a09cd5d659ceca4db39d7d2370a17f8c21f62e7186d34103323f"} 19:50:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:50:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:50:50 INFO - Contents: 19:50:50 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17b8dfff38a69e029ccb19647ee9f4131c6b3868ca5afdd40352f026c4072d8f20ad27f13a89d5ac0aeed367e699c5f398b076c539de89744f995338fc1cb40f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1869c6605b9d8d6c3084c4e3f238504f2cfaa6efe5d2fa37037fbcfd4b55f49b15335258cb59c87aa8668e90b808269b34d43252c652c319d3453f10854ff347", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c4d9a5e12760483173ff2c0f164800a3be5543e4bf5d814b1175ec18cdb78d6bdcdc86a3a15be29e9db7d00c1795ece8b4d2435f11b8e980a008597c202ef5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a288b1a9ecc1d5a98ba10b4276f6cf691c22399b9b1a2be8c11e4107578498989343422762a09cd5d659ceca4db39d7d2370a17f8c21f62e7186d34103323f"} 19:50:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:50:50 INFO - Copying logs to upload dir... 19:50:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:50:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.329814 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-27 19:50:50.121612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 19:50:50.124920) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857 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/17b8dfff38a69e029ccb19647ee9f4131c6b3868ca5afdd40352f026c4072d8f20ad27f13a89d5ac0aeed367e699c5f398b076c539de89744f995338fc1cb40f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1869c6605b9d8d6c3084c4e3f238504f2cfaa6efe5d2fa37037fbcfd4b55f49b15335258cb59c87aa8668e90b808269b34d43252c652c319d3453f10854ff347", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c4d9a5e12760483173ff2c0f164800a3be5543e4bf5d814b1175ec18cdb78d6bdcdc86a3a15be29e9db7d00c1795ece8b4d2435f11b8e980a008597c202ef5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a288b1a9ecc1d5a98ba10b4276f6cf691c22399b9b1a2be8c11e4107578498989343422762a09cd5d659ceca4db39d7d2370a17f8c21f62e7186d34103323f"} build_url:https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/ZYcIjL_vT_-NqcCrfCI1Aw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/17b8dfff38a69e029ccb19647ee9f4131c6b3868ca5afdd40352f026c4072d8f20ad27f13a89d5ac0aeed367e699c5f398b076c539de89744f995338fc1cb40f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1869c6605b9d8d6c3084c4e3f238504f2cfaa6efe5d2fa37037fbcfd4b55f49b15335258cb59c87aa8668e90b808269b34d43252c652c319d3453f10854ff347", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7c4d9a5e12760483173ff2c0f164800a3be5543e4bf5d814b1175ec18cdb78d6bdcdc86a3a15be29e9db7d00c1795ece8b4d2435f11b8e980a008597c202ef5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a288b1a9ecc1d5a98ba10b4276f6cf691c22399b9b1a2be8c11e4107578498989343422762a09cd5d659ceca4db39d7d2370a17f8c21f62e7186d34103323f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 19:50:50.153184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 19:50:50.153581) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1506565359.887495-792930857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 19:50:50.238472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 19:50:50.238785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 19:50:50.239098) ========= ========= Total master_lag: 0.10 =========