builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1506460886.11 results: success (0) revision: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.108040) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.108509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.108847) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.340779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.341054) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 14:21:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.1M=0.001s 2017-09-26 14:21:26 (23.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.287594 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.664823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.665148) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020036 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.724142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-26 14:21:26.727523) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b --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 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b --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=9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 14:21:26,778 truncating revision to first 12 chars 2017-09-26 14:21:26,778 Setting DEBUG logging. 2017-09-26 14:21:26,778 attempt 1/10 2017-09-26 14:21:26,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d15bc419c6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 14:21:27,860 attempt 1/10 2017-09-26 14:21:28,525 current task status: no status available at this point. state: STARTED 2017-09-26 14:21:28,525 sleeping for 9.00s (attempt 1/10) 2017-09-26 14:21:37,534 attempt 2/10 2017-09-26 14:21:37,870 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-26 14:21:38,050 unpacking tar archive at: mozilla-central-7d15bc419c6c/testing/mozharness/ program finished with exit code 0 elapsedTime=11.558225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-26 14:21:38.301204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.301524) ========= script_repo_revision: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.301888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.302171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.333476) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-26 14:21:38.333842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:21:38 INFO - MultiFileLogger online at 20170926 14:21:38 in /builds/slave/test 14:21:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-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 14:21:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:38 INFO - {'append_to_log': False, 14:21:38 INFO - 'base_work_dir': '/builds/slave/test', 14:21:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:21:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:38 INFO - 'branch': 'Firefox-Non-PGO', 14:21:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:38 INFO - 'code_coverage': False, 14:21:38 INFO - 'config_files': ('talos/linux_config.py',), 14:21:38 INFO - 'default_actions': ('clobber', 14:21:38 INFO - 'read-buildbot-config', 14:21:38 INFO - 'download-and-extract', 14:21:38 INFO - 'populate-webroot', 14:21:38 INFO - 'create-virtualenv', 14:21:38 INFO - 'install', 14:21:38 INFO - 'setup-mitmproxy', 14:21:38 INFO - 'run-tests'), 14:21:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:38 INFO - 'disable_ccov_upload': False, 14:21:38 INFO - 'disable_stylo': False, 14:21:38 INFO - 'download_minidump_stackwalk': True, 14:21:38 INFO - 'download_symbols': 'ondemand', 14:21:38 INFO - 'enable_stylo': False, 14:21:38 INFO - 'enable_webrender': False, 14:21:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:21:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:38 INFO - 'gecko_profile': False, 14:21:38 INFO - 'gecko_profile_interval': 0, 14:21:38 INFO - 'installer_path': 'installer.exe', 14:21:38 INFO - 'log_level': 'info', 14:21:38 INFO - 'log_name': 'talos', 14:21:38 INFO - 'log_to_console': True, 14:21:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:21:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:21:38 INFO - 'opt_config_files': (), 14:21:38 INFO - 'pip_index': False, 14:21:38 INFO - 'suite': 'dromaeojs-e10s', 14:21:38 INFO - 'system_bits': '32', 14:21:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:38 INFO - 'title': 'talos-linux64-ix-013', 14:21:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:38 INFO - 'use_talos_json': True, 14:21:38 INFO - 'verify': 'False', 14:21:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:38 INFO - 'work_dir': 'build'} 14:21:38 INFO - [mozharness: 2017-09-26 21:21:38.533901Z] Running clobber step. 14:21:38 INFO - Running pre-action listener: _resource_record_pre_action 14:21:38 INFO - Running main action method: clobber 14:21:38 INFO - rmtree: /builds/slave/test/build 14:21:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:40 INFO - Running post-action listener: _resource_record_post_action 14:21:40 INFO - [mozharness: 2017-09-26 21:21:40.048600Z] Finished clobber step (success) 14:21:40 INFO - [mozharness: 2017-09-26 21:21:40.048698Z] Running read-buildbot-config step. 14:21:40 INFO - Running pre-action listener: _resource_record_pre_action 14:21:40 INFO - Running main action method: read_buildbot_config 14:21:40 INFO - Using buildbot properties: 14:21:40 INFO - { 14:21:40 INFO - "project": "", 14:21:40 INFO - "product": "firefox", 14:21:40 INFO - "who": "kwierso@gmail.com", 14:21:40 INFO - "installer_path": "public/build/target.tar.bz2", 14:21:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:21:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:21:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:21:40 INFO - "stage_platform": "linux64", 14:21:40 INFO - "basedir": "/builds/slave/test", 14:21:40 INFO - "buildnumber": 868, 14:21:40 INFO - "platform": "ubuntu64_hw", 14:21:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:21:40 INFO - "slavebuilddir": "test", 14:21:40 INFO - "taskId": "dFwJuUonRxKAM98Ol7T2Bg", 14:21:40 INFO - "branch": "mozilla-central", 14:21:40 INFO - "script_repo_revision": "production", 14:21:40 INFO - "revision": "7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b", 14:21:40 INFO - "slavename": "talos-linux64-ix-013", 14:21:40 INFO - "repo_path": "mozilla-central" 14:21:40 INFO - } 14:21:40 INFO - Finding installer, test and symbols from parent task. 14:21:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dFwJuUonRxKAM98Ol7T2Bg'}, attempt #1 14:21:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dFwJuUonRxKAM98Ol7T2Bg'}, attempt #1 14:21:40 INFO - Task dependencies: DmeAWeThR7WU_DFoThmLQA 14:21:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA'}, attempt #1 14:21:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json 14:21:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip 14:21:41 INFO - Running post-action listener: _resource_record_post_action 14:21:41 INFO - [mozharness: 2017-09-26 21:21:41.428343Z] Finished read-buildbot-config step (success) 14:21:41 INFO - [mozharness: 2017-09-26 21:21:41.428558Z] Running download-and-extract step. 14:21:41 INFO - Running pre-action listener: _resource_record_pre_action 14:21:41 INFO - Running main action method: download_and_extract 14:21:41 INFO - mkdir: /builds/slave/test/build/tests 14:21: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')]} 14:21:41 INFO - trying https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json 14:21:41 INFO - Downloading https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:21:41 INFO - Downloaded 989 bytes. 14:21:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:21:41 INFO - Using the following test package requirements: 14:21:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:21:41 INFO - u'common': [u'target.common.tests.zip'], 14:21:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:21:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:21:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:21:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:21:41 INFO - u'mozbase': [u'target.common.tests.zip'], 14:21:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:21:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:21:41 INFO - u'web-platform': [u'target.common.tests.zip', 14:21:41 INFO - u'target.web-platform.tests.tar.gz'], 14:21:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:21:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:21:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.common.tests.zip 14:21:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:21:41 INFO - Fetch https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.common.tests.zip into memory 14:21:43 INFO - Content-Length response header: 54945059 14:21:43 INFO - Bytes received: 54945059 14:21:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.talos.tests.zip 14:21:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:21:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.talos.tests.zip into memory 14:21:54 INFO - Content-Length response header: 14513823 14:21:54 INFO - Bytes received: 14513823 14:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:54 INFO - trying https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:54 INFO - Downloading https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:21:56 INFO - Downloaded 61630124 bytes. 14:21:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:56 INFO - mkdir: /builds/slave/test/properties 14:21:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:56 INFO - Contents: 14:21:56 INFO - build_url:https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:56 INFO - Running post-action listener: _resource_record_post_action 14:21:56 INFO - Running post-action listener: find_tests_for_verification 14:21:56 INFO - Running post-action listener: set_extra_try_arguments 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.523679Z] Finished download-and-extract step (success) 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.523831Z] Running populate-webroot step. 14:21:56 INFO - Running pre-action listener: _resource_record_pre_action 14:21:56 INFO - Running main action method: populate_webroot 14:21:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tresize', 14:21:56 INFO - 'tcanvasmark']}, 14:21:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['dromaeo_css', 14:21:56 INFO - 'kraken']}, 14:21:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'tests': ['damp', 'tps']}, 14:21:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['damp', 'tps']}, 14:21:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['dromaeo_dom']}, 14:21:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:21:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['basic_compositor_video', 14:21:56 INFO - 'glvideo']}, 14:21:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:21:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['ts_paint_webext', 14:21:56 INFO - 'tp5o_webext']}, 14:21:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:56 INFO - 'ts_paint', 14:21:56 INFO - 'tpaint', 14:21:56 INFO - 'sessionrestore', 14:21:56 INFO - 'sessionrestore_many_windows', 14:21:56 INFO - 'sessionrestore_no_auto_restore', 14:21:56 INFO - 'tabpaint']}, 14:21:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['a11yr', 14:21:56 INFO - 'ts_paint', 14:21:56 INFO - 'tpaint', 14:21:56 INFO - 'sessionrestore', 14:21:56 INFO - 'sessionrestore_many_windows', 14:21:56 INFO - 'sessionrestore_no_auto_restore', 14:21:56 INFO - 'tabpaint']}, 14:21:56 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 14:21:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:21:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['perf_reftest_singletons']}, 14:21:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['perf_reftest']}, 14:21:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:56 INFO - 'tsvgr_opacity', 14:21:56 INFO - 'tart', 14:21:56 INFO - 'tscrollx', 14:21:56 INFO - 'tsvg_static']}, 14:21:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tsvgx', 14:21:56 INFO - 'tsvgr_opacity', 14:21:56 INFO - 'tart', 14:21:56 INFO - 'tscrollx', 14:21:56 INFO - 'tsvg_static']}, 14:21:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:21:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tp5o']}, 14:21:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:21:56 INFO - 'talos_options': ['--mitmproxy', 14:21:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:56 INFO - '--firstNonBlankPaint'], 14:21:56 INFO - 'tests': ['tp6_google', 14:21:56 INFO - 'tp6_youtube', 14:21:56 INFO - 'tp6_amazon', 14:21:56 INFO - 'tp6_facebook']}, 14:21:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:21:56 INFO - 'talos_options': ['--disable-stylo', 14:21:56 INFO - '--mitmproxy', 14:21:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:56 INFO - '--firstNonBlankPaint'], 14:21:56 INFO - 'tests': ['tp6_google', 14:21:56 INFO - 'tp6_youtube', 14:21:56 INFO - 'tp6_amazon', 14:21:56 INFO - 'tp6_facebook']}, 14:21:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:21:56 INFO - 'talos_options': ['--stylo-threads=1', 14:21:56 INFO - '--mitmproxy', 14:21:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:56 INFO - '--firstNonBlankPaint'], 14:21:56 INFO - 'tests': ['tp6_google', 14:21:56 INFO - 'tp6_youtube', 14:21:56 INFO - 'tp6_amazon', 14:21:56 INFO - 'tp6_facebook']}, 14:21:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--xperf_path', 14:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:56 INFO - 'tests': ['tp5n']}, 14:21:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo', 14:21:56 INFO - '--xperf_path', 14:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:56 INFO - 'tests': ['tp5n']}}} 14:21:56 INFO - Running post-action listener: _resource_record_post_action 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.547268Z] Finished populate-webroot step (success) 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.547376Z] Running create-virtualenv step. 14:21:56 INFO - Running pre-action listener: _resource_record_pre_action 14:21:56 INFO - Running main action method: create_virtualenv 14:21:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:21:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:21:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:21:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:57 INFO - Installing pip...............done. 14:21:57 INFO - Return code: 0 14:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:21:57 INFO - Reading from file tmpfile_stdout 14:21:57 INFO - Output received: 14:21:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:21:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:21:57 INFO - Using env: {'DISPLAY': ':0', 14:21:57 INFO - 'HOME': '/home/cltbld', 14:21:57 INFO - 'LANG': 'en_US.UTF-8', 14:21:57 INFO - 'LANGUAGE': 'en_US:en', 14:21:57 INFO - 'LOGNAME': 'cltbld', 14:21:57 INFO - 'MAIL': '/var/mail/cltbld', 14:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:57 INFO - 'MOZ_NO_REMOTE': '1', 14:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:57 INFO - 'NO_EM_RESTART': '1', 14:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:57 INFO - 'PWD': '/builds/slave/test', 14:21:57 INFO - 'SHELL': '/bin/bash', 14:21:57 INFO - 'SHLVL': '1', 14:21:57 INFO - 'TERM': 'linux', 14:21:57 INFO - 'TMOUT': '86400', 14:21:57 INFO - 'USER': 'cltbld', 14:21:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:57 INFO - '_': '/tools/buildbot/bin/python'} 14:21:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:21:59 INFO - Downloading/unpacking pip>=1.5 14:21:59 INFO - Running setup.py egg_info for package pip 14:21:59 INFO - warning: no files found matching 'pip/cacert.pem' 14:21:59 INFO - warning: no files found matching '*.html' under directory 'docs' 14:21:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:21:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:21:59 INFO - Installing collected packages: pip 14:21:59 INFO - Found existing installation: pip 1.1 14:21:59 INFO - Uninstalling pip: 14:21:59 INFO - Successfully uninstalled pip 14:21:59 INFO - Running setup.py install for pip 14:21:59 INFO - warning: no files found matching 'pip/cacert.pem' 14:21:59 INFO - warning: no files found matching '*.html' under directory 'docs' 14:21:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:21:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:21:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Successfully installed pip 14:21:59 INFO - Cleaning up... 14:21:59 INFO - Return code: 0 14:21:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:21:59 INFO - Using env: {'DISPLAY': ':0', 14:21:59 INFO - 'HOME': '/home/cltbld', 14:21:59 INFO - 'LANG': 'en_US.UTF-8', 14:21:59 INFO - 'LANGUAGE': 'en_US:en', 14:21:59 INFO - 'LOGNAME': 'cltbld', 14:21:59 INFO - 'MAIL': '/var/mail/cltbld', 14:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:59 INFO - 'MOZ_NO_REMOTE': '1', 14:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:59 INFO - 'NO_EM_RESTART': '1', 14:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:59 INFO - 'PWD': '/builds/slave/test', 14:21:59 INFO - 'SHELL': '/bin/bash', 14:21:59 INFO - 'SHLVL': '1', 14:21:59 INFO - 'TERM': 'linux', 14:21:59 INFO - 'TMOUT': '86400', 14:21:59 INFO - 'USER': 'cltbld', 14:21:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:59 INFO - '_': '/tools/buildbot/bin/python'} 14:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:59 INFO - Downloading/unpacking psutil>=3.1.1 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:00 INFO - Installing collected packages: psutil 14:22:00 INFO - Running setup.py install for psutil 14:22:00 INFO - building 'psutil._psutil_linux' extension 14:22:00 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 14:22:00 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 14:22:00 INFO - building 'psutil._psutil_posix' extension 14:22:00 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 14:22:00 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 14:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:00 INFO - Successfully installed psutil 14:22:00 INFO - Cleaning up... 14:22:01 INFO - Return code: 0 14:22:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22:01 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')]} 14:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:01 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')]} 14:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:01 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 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:01 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 14:22:01 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 14:22:01 INFO - Using env: {'DISPLAY': ':0', 14:22:01 INFO - 'HOME': '/home/cltbld', 14:22:01 INFO - 'LANG': 'en_US.UTF-8', 14:22:01 INFO - 'LANGUAGE': 'en_US:en', 14:22:01 INFO - 'LOGNAME': 'cltbld', 14:22:01 INFO - 'MAIL': '/var/mail/cltbld', 14:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:01 INFO - 'MOZ_NO_REMOTE': '1', 14:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:01 INFO - 'NO_EM_RESTART': '1', 14:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:01 INFO - 'PWD': '/builds/slave/test', 14:22:01 INFO - 'SHELL': '/bin/bash', 14:22:01 INFO - 'SHLVL': '1', 14:22:01 INFO - 'TERM': 'linux', 14:22:01 INFO - 'TMOUT': '86400', 14:22:01 INFO - 'USER': 'cltbld', 14:22:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:01 INFO - '_': '/tools/buildbot/bin/python'} 14:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:02 INFO - Installing collected packages: mozsystemmonitor 14:22:02 INFO - Running setup.py install for mozsystemmonitor 14:22:02 INFO - Successfully installed mozsystemmonitor 14:22:02 INFO - Cleaning up... 14:22:04 INFO - Return code: 0 14:22:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:22:04 INFO - Using env: {'DISPLAY': ':0', 14:22:04 INFO - 'HOME': '/home/cltbld', 14:22:04 INFO - 'LANG': 'en_US.UTF-8', 14:22:04 INFO - 'LANGUAGE': 'en_US:en', 14:22:04 INFO - 'LOGNAME': 'cltbld', 14:22:04 INFO - 'MAIL': '/var/mail/cltbld', 14:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:04 INFO - 'MOZ_NO_REMOTE': '1', 14:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:04 INFO - 'NO_EM_RESTART': '1', 14:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:04 INFO - 'PWD': '/builds/slave/test', 14:22:04 INFO - 'SHELL': '/bin/bash', 14:22:04 INFO - 'SHLVL': '1', 14:22:04 INFO - 'TERM': 'linux', 14:22:04 INFO - 'TMOUT': '86400', 14:22:04 INFO - 'USER': 'cltbld', 14:22:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:04 INFO - '_': '/tools/buildbot/bin/python'} 14:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:04 INFO - Downloading/unpacking jsonschema==2.5.1 14:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:05 INFO - warning: no files found matching '*.txt' 14:22:05 INFO - no previously-included directories found matching 'build' 14:22:05 INFO - no previously-included directories found matching 'dist' 14:22:05 INFO - no previously-included directories found matching '.git*' 14:22:05 INFO - Installing collected packages: jsonschema, functools32 14:22:05 INFO - Running setup.py install for functools32 14:22:05 INFO - warning: no files found matching '*.txt' 14:22:05 INFO - no previously-included directories found matching 'build' 14:22:05 INFO - no previously-included directories found matching 'dist' 14:22:05 INFO - no previously-included directories found matching '.git*' 14:22:05 INFO - Successfully installed jsonschema functools32 14:22:05 INFO - Cleaning up... 14:22:05 INFO - Return code: 0 14:22:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:22:05 INFO - Using env: {'DISPLAY': ':0', 14:22:05 INFO - 'HOME': '/home/cltbld', 14:22:05 INFO - 'LANG': 'en_US.UTF-8', 14:22:05 INFO - 'LANGUAGE': 'en_US:en', 14:22:05 INFO - 'LOGNAME': 'cltbld', 14:22:05 INFO - 'MAIL': '/var/mail/cltbld', 14:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:05 INFO - 'MOZ_NO_REMOTE': '1', 14:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:05 INFO - 'NO_EM_RESTART': '1', 14:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:05 INFO - 'PWD': '/builds/slave/test', 14:22:05 INFO - 'SHELL': '/bin/bash', 14:22:05 INFO - 'SHLVL': '1', 14:22:05 INFO - 'TERM': 'linux', 14:22:05 INFO - 'TMOUT': '86400', 14:22:05 INFO - 'USER': 'cltbld', 14:22:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:05 INFO - '_': '/tools/buildbot/bin/python'} 14:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:22:06 INFO - Cleaning up... 14:22:06 INFO - Return code: 0 14:22:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:22:06 INFO - Using env: {'DISPLAY': ':0', 14:22:06 INFO - 'HOME': '/home/cltbld', 14:22:06 INFO - 'LANG': 'en_US.UTF-8', 14:22:06 INFO - 'LANGUAGE': 'en_US:en', 14:22:06 INFO - 'LOGNAME': 'cltbld', 14:22:06 INFO - 'MAIL': '/var/mail/cltbld', 14:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:06 INFO - 'MOZ_NO_REMOTE': '1', 14:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:06 INFO - 'NO_EM_RESTART': '1', 14:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:06 INFO - 'PWD': '/builds/slave/test', 14:22:06 INFO - 'SHELL': '/bin/bash', 14:22:06 INFO - 'SHLVL': '1', 14:22:06 INFO - 'TERM': 'linux', 14:22:06 INFO - 'TMOUT': '86400', 14:22:06 INFO - 'USER': 'cltbld', 14:22:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:06 INFO - '_': '/tools/buildbot/bin/python'} 14:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:07 INFO - Downloading docopt-0.6.1.tar.gz 14:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:08 INFO - Running setup.py install for blobuploader 14:22:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:08 INFO - Running setup.py install for requests 14:22:08 INFO - Running setup.py install for docopt 14:22:08 INFO - Successfully installed blobuploader requests docopt 14:22:08 INFO - Cleaning up... 14:22:08 INFO - Return code: 0 14:22:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:22:08 INFO - Using env: {'DISPLAY': ':0', 14:22:08 INFO - 'HOME': '/home/cltbld', 14:22:08 INFO - 'LANG': 'en_US.UTF-8', 14:22:08 INFO - 'LANGUAGE': 'en_US:en', 14:22:08 INFO - 'LOGNAME': 'cltbld', 14:22:08 INFO - 'MAIL': '/var/mail/cltbld', 14:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:08 INFO - 'MOZ_NO_REMOTE': '1', 14:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:08 INFO - 'NO_EM_RESTART': '1', 14:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:08 INFO - 'PWD': '/builds/slave/test', 14:22:08 INFO - 'SHELL': '/bin/bash', 14:22:08 INFO - 'SHLVL': '1', 14:22:08 INFO - 'TERM': 'linux', 14:22:08 INFO - 'TMOUT': '86400', 14:22:08 INFO - 'USER': 'cltbld', 14:22:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:08 INFO - '_': '/tools/buildbot/bin/python'} 14:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:08 INFO - Running setup.py (path:/tmp/pip-oN44Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:08 INFO - Running setup.py (path:/tmp/pip-PB1qMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:09 INFO - Running setup.py (path:/tmp/pip-ltLqG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:09 INFO - Running setup.py (path:/tmp/pip-efuOyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:09 INFO - Running setup.py (path:/tmp/pip-NOoebw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:09 INFO - Running setup.py (path:/tmp/pip-92xvYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:09 INFO - Running setup.py (path:/tmp/pip-Jv8wp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:09 INFO - Running setup.py (path:/tmp/pip-EDQQbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:09 INFO - Running setup.py (path:/tmp/pip-Gp41Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:09 INFO - Running setup.py (path:/tmp/pip-7QUDU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:09 INFO - Running setup.py (path:/tmp/pip-WynFQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:09 INFO - Running setup.py (path:/tmp/pip-04IY0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:09 INFO - Running setup.py (path:/tmp/pip-iOjGYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:09 INFO - Running setup.py (path:/tmp/pip-AVQ2Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:09 INFO - Running setup.py (path:/tmp/pip-hZmM7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:09 INFO - Running setup.py (path:/tmp/pip-40lm0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:10 INFO - Running setup.py (path:/tmp/pip-uquyiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:10 INFO - Running setup.py install for manifestparser 14:22:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Running setup.py install for mozcrash 14:22:10 INFO - Running setup.py install for mozdebug 14:22:10 INFO - Running setup.py install for mozdevice 14:22:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Running setup.py install for mozfile 14:22:10 INFO - Running setup.py install for mozhttpd 14:22:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Running setup.py install for mozinfo 14:22:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Running setup.py install for mozInstall 14:22:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Running setup.py install for mozleak 14:22:10 INFO - Running setup.py install for mozlog 14:22:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for moznetwork 14:22:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozprocess 14:22:11 INFO - Running setup.py install for mozprofile 14:22:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozrunner 14:22:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozscreenshot 14:22:11 INFO - Running setup.py install for moztest 14:22:11 INFO - Running setup.py install for mozversion 14:22:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:11 INFO - Cleaning up... 14:22:11 INFO - Return code: 0 14:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:22:11 INFO - Using env: {'DISPLAY': ':0', 14:22:11 INFO - 'HOME': '/home/cltbld', 14:22:11 INFO - 'LANG': 'en_US.UTF-8', 14:22:11 INFO - 'LANGUAGE': 'en_US:en', 14:22:11 INFO - 'LOGNAME': 'cltbld', 14:22:11 INFO - 'MAIL': '/var/mail/cltbld', 14:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:11 INFO - 'MOZ_NO_REMOTE': '1', 14:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:11 INFO - 'NO_EM_RESTART': '1', 14:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:11 INFO - 'PWD': '/builds/slave/test', 14:22:11 INFO - 'SHELL': '/bin/bash', 14:22:11 INFO - 'SHLVL': '1', 14:22:11 INFO - 'TERM': 'linux', 14:22:11 INFO - 'TMOUT': '86400', 14:22:11 INFO - 'USER': 'cltbld', 14:22:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:11 INFO - '_': '/tools/buildbot/bin/python'} 14:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:12 INFO - Running setup.py (path:/tmp/pip-lOqDfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:12 INFO - Running setup.py (path:/tmp/pip-y3_Sg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:12 INFO - Running setup.py (path:/tmp/pip-Qcq4E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:12 INFO - Running setup.py (path:/tmp/pip-Ol5iWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:12 INFO - Running setup.py (path:/tmp/pip-pp0BQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:12 INFO - Running setup.py (path:/tmp/pip-gMeD9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:12 INFO - Running setup.py (path:/tmp/pip-EFvXBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:12 INFO - Running setup.py (path:/tmp/pip-UFWWLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:12 INFO - Running setup.py (path:/tmp/pip-7AHLrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:12 INFO - Running setup.py (path:/tmp/pip-FucPu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:12 INFO - Running setup.py (path:/tmp/pip-Eu5MYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:12 INFO - Running setup.py (path:/tmp/pip-mUoqbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:12 INFO - Running setup.py (path:/tmp/pip-m_WSuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:12 INFO - Running setup.py (path:/tmp/pip-R8Wwj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:13 INFO - Running setup.py (path:/tmp/pip-DvXoke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:13 INFO - Running setup.py (path:/tmp/pip-FBmNlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:13 INFO - Running setup.py (path:/tmp/pip-veGh6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:22:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:14 INFO - Downloading blessings-1.6.tar.gz 14:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:14 INFO - Installing collected packages: blessings 14:22:14 INFO - Running setup.py install for blessings 14:22:14 INFO - Successfully installed blessings 14:22:14 INFO - Cleaning up... 14:22:14 INFO - Return code: 0 14:22:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:14 INFO - Reading from file tmpfile_stdout 14:22:14 INFO - Current package versions: 14:22:14 INFO - argparse == 1.2.1 14:22:14 INFO - blessings == 1.6 14:22:14 INFO - blobuploader == 1.2.4 14:22:14 INFO - docopt == 0.6.1 14:22:14 INFO - functools32 == 3.2.3-2 14:22:14 INFO - jsonschema == 2.5.1 14:22:14 INFO - manifestparser == 1.1 14:22:14 INFO - mozInstall == 1.13 14:22:14 INFO - mozcrash == 1.0 14:22:14 INFO - mozdebug == 0.1 14:22:14 INFO - mozdevice == 0.51 14:22:14 INFO - mozfile == 1.2 14:22:14 INFO - mozhttpd == 0.7 14:22:14 INFO - mozinfo == 0.10 14:22:14 INFO - mozleak == 0.1 14:22:14 INFO - mozlog == 3.5 14:22:14 INFO - moznetwork == 0.27 14:22:14 INFO - mozprocess == 0.25 14:22:14 INFO - mozprofile == 0.28 14:22:14 INFO - mozrunner == 6.13 14:22:14 INFO - mozscreenshot == 0.1 14:22:14 INFO - mozsystemmonitor == 0.3 14:22:14 INFO - moztest == 0.8 14:22:14 INFO - mozversion == 1.4 14:22:14 INFO - psutil == 3.1.1 14:22:14 INFO - requests == 1.2.3 14:22:14 INFO - wsgiref == 0.1.2 14:22:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:22:14 INFO - Using env: {'DISPLAY': ':0', 14:22:14 INFO - 'HOME': '/home/cltbld', 14:22:14 INFO - 'LANG': 'en_US.UTF-8', 14:22:14 INFO - 'LANGUAGE': 'en_US:en', 14:22:14 INFO - 'LOGNAME': 'cltbld', 14:22:14 INFO - 'MAIL': '/var/mail/cltbld', 14:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:14 INFO - 'MOZ_NO_REMOTE': '1', 14:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:14 INFO - 'NO_EM_RESTART': '1', 14:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:14 INFO - 'PWD': '/builds/slave/test', 14:22:14 INFO - 'SHELL': '/bin/bash', 14:22:14 INFO - 'SHLVL': '1', 14:22:14 INFO - 'TERM': 'linux', 14:22:14 INFO - 'TMOUT': '86400', 14:22:14 INFO - 'USER': 'cltbld', 14:22:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:14 INFO - '_': '/tools/buildbot/bin/python'} 14:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:22:15 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 14:22:15 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 14:22:15 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 14:22:15 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 14:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:22:16 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)) 14:22:16 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)) 14:22:16 INFO - Installing collected packages: simplejson 14:22:16 INFO - Running setup.py install for simplejson 14:22:16 INFO - building 'simplejson._speedups' extension 14:22:16 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 14:22:17 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 14:22:17 INFO - Successfully installed simplejson 14:22:17 INFO - Cleaning up... 14:22:17 INFO - Return code: 0 14:22:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:17 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')]} 14:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:17 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')]} 14:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:17 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 0xadd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', '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 14:22:17 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 14:22:17 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 14:22:17 INFO - Using env: {'DISPLAY': ':0', 14:22:17 INFO - 'HOME': '/home/cltbld', 14:22:17 INFO - 'LANG': 'en_US.UTF-8', 14:22:17 INFO - 'LANGUAGE': 'en_US:en', 14:22:17 INFO - 'LOGNAME': 'cltbld', 14:22:17 INFO - 'MAIL': '/var/mail/cltbld', 14:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:17 INFO - 'MOZ_NO_REMOTE': '1', 14:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:17 INFO - 'NO_EM_RESTART': '1', 14:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:17 INFO - 'PWD': '/builds/slave/test', 14:22:17 INFO - 'SHELL': '/bin/bash', 14:22:17 INFO - 'SHLVL': '1', 14:22:17 INFO - 'TERM': 'linux', 14:22:17 INFO - 'TMOUT': '86400', 14:22:17 INFO - 'USER': 'cltbld', 14:22:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:17 INFO - '_': '/tools/buildbot/bin/python'} 14:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:17 INFO - Cleaning up... 14:22:17 INFO - Return code: 0 14:22:17 INFO - Running post-action listener: _resource_record_post_action 14:22:17 INFO - Running post-action listener: _start_resource_monitoring 14:22:17 INFO - Starting resource monitoring. 14:22:17 INFO - [mozharness: 2017-09-26 21:22:17.503261Z] Finished create-virtualenv step (success) 14:22:17 INFO - [mozharness: 2017-09-26 21:22:17.503782Z] Running install step. 14:22:17 INFO - Running pre-action listener: _resource_record_pre_action 14:22:17 INFO - Running main action method: install 14:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:17 INFO - Reading from file tmpfile_stdout 14:22:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:17 INFO - Reading from file tmpfile_stdout 14:22:17 INFO - Output received: 14:22:17 INFO - Usage: mozinstall [options] installer 14:22:17 INFO - Options: 14:22:17 INFO - -h, --help show this help message and exit 14:22:17 INFO - -d DEST, --destination=DEST 14:22:17 INFO - Directory to install application into. [default: 14:22:17 INFO - "/builds/slave/test"] 14:22:17 INFO - --app=APP Application being installed. [default: firefox] 14:22:17 INFO - mkdir: /builds/slave/test/build/application 14:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:22:35 INFO - Reading from file tmpfile_stdout 14:22:35 INFO - Output received: 14:22:35 INFO - /builds/slave/test/build/application/firefox/firefox 14:22:35 INFO - Running post-action listener: _resource_record_post_action 14:22:35 INFO - [mozharness: 2017-09-26 21:22:35.654657Z] Finished install step (success) 14:22:35 INFO - [mozharness: 2017-09-26 21:22:35.654908Z] Running setup-mitmproxy step. 14:22:35 INFO - Running pre-action listener: _resource_record_pre_action 14:22:35 INFO - Running main action method: setup_mitmproxy 14:22:35 INFO - Skipping: mitmproxy is not required 14:22:35 INFO - Running post-action listener: _resource_record_post_action 14:22:35 INFO - [mozharness: 2017-09-26 21:22:35.656025Z] Finished setup-mitmproxy step (success) 14:22:35 INFO - [mozharness: 2017-09-26 21:22:35.656245Z] Running run-tests step. 14:22:35 INFO - Running pre-action listener: _resource_record_pre_action 14:22:35 INFO - Running pre-action listener: _set_gcov_prefix 14:22:35 INFO - Running main action method: run_tests 14:22:35 WARNING - Try message not found. 14:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:35 INFO - Python 2.7.3 14:22:35 INFO - Return code: 0 14:22:35 INFO - grabbing minidump binary from tooltool 14:22: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')]} 14:22:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c440>, '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 0xe4d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe47320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:22:35 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:22:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:22:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:35 INFO - Return code: 0 14:22:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:22:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:35 INFO - ENV: RUST_BACKTRACE is now full 14:22:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:22:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:35 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:22:35 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:22:35 INFO - Using env: {'DISPLAY': ':0', 14:22:35 INFO - 'HOME': '/home/cltbld', 14:22:35 INFO - 'LANG': 'en_US.UTF-8', 14:22:35 INFO - 'LANGUAGE': 'en_US:en', 14:22:35 INFO - 'LOGNAME': 'cltbld', 14:22:35 INFO - 'MAIL': '/var/mail/cltbld', 14:22:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:35 INFO - 'MOZ_NO_REMOTE': '1', 14:22:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:35 INFO - 'NO_EM_RESTART': '1', 14:22:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:35 INFO - 'PWD': '/builds/slave/test', 14:22:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:35 INFO - 'RUST_BACKTRACE': 'full', 14:22:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:22:35 INFO - 'SHELL': '/bin/bash', 14:22:35 INFO - 'SHLVL': '1', 14:22:35 INFO - 'TERM': 'linux', 14:22:35 INFO - 'TMOUT': '86400', 14:22:35 INFO - 'USER': 'cltbld', 14:22:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:35 INFO - '_': '/tools/buildbot/bin/python'} 14:22:35 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:22:36 INFO - mozversion application_buildid: 20170926203052 14:22:36 INFO - mozversion application_changeset: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b 14:22:36 INFO - mozversion application_display_name: Nightly 14:22:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:36 INFO - mozversion application_name: Firefox 14:22:36 INFO - mozversion application_remotingname: firefox 14:22:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:22:36 INFO - mozversion application_vendor: Mozilla 14:22:36 INFO - mozversion application_version: 58.0a1 14:22:36 INFO - mozversion platform_buildid: 20170926203052 14:22:36 INFO - mozversion platform_changeset: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b 14:22:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:22:36 INFO - mozversion platform_version: 58.0a1 14:22:36 INFO - using testdate: 1506460956 14:22:36 INFO - actual date: 1506460956 14:22:36 INFO - starting webserver on 'localhost:58416' 14:22:36 INFO - SUITE-START | Running 2 tests 14:22:36 INFO - TEST-START | dromaeo_css 14:22:36 INFO - Initialising browser for dromaeo_css test... 14:22:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58416/getInfo.html -profile /tmp/tmpN9baZR/profile 14:22:36 INFO - TEST-INFO | started process 16572 (/builds/slave/test/build/application/firefox/firefox http://localhost:58416/getInfo.html) 14:22:41 INFO - TEST-INFO | 16572: exit 0 14:22:41 INFO - Browser initialized. 14:22:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:41 INFO - Using env: {'DISPLAY': ':0', 14:22:41 INFO - 'HOME': '/home/cltbld', 14:22:41 INFO - 'JSGC_DISABLE_POISONING': '1', 14:22:41 INFO - 'LANG': 'en_US.UTF-8', 14:22:41 INFO - 'LANGUAGE': 'en_US:en', 14:22:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:22:41 INFO - 'LOGNAME': 'cltbld', 14:22:41 INFO - 'MAIL': '/var/mail/cltbld', 14:22:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:41 INFO - 'MOZ_CRASHREPORTER': '1', 14:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:22:41 INFO - 'MOZ_NO_REMOTE': '1', 14:22:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:41 INFO - 'NO_EM_RESTART': '1', 14:22:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:41 INFO - 'PWD': '/builds/slave/test', 14:22:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:41 INFO - 'RUST_BACKTRACE': 'full', 14:22:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:22:41 INFO - 'SHELL': '/bin/bash', 14:22:41 INFO - 'SHLVL': '1', 14:22:41 INFO - 'TERM': 'linux', 14:22:41 INFO - 'TMOUT': '86400', 14:22:41 INFO - 'USER': 'cltbld', 14:22:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:41 INFO - '_': '/tools/buildbot/bin/python'} 14:22:41 INFO - TEST-INFO | started process 16804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN9baZR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:42 INFO - PID 16804 | 14:22:42 INFO - PID 16804 | (/builds/slave/test/build/application/firefox/firefox:16854): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:22:42 INFO - PID 16804 | 14:22:52 INFO - PID 16804 | RSS: Main: 153022464 14:22:52 INFO - PID 16804 | 14:25:51 INFO - PID 16804 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58416/tests/dromaeo/cssquery-ext.html) 14:25:52 INFO - PID 16804 | RSS: Main: 152985600 14:25:52 INFO - PID 16804 | 14:28:54 INFO - PID 16804 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-ext.html (next: http://localhost:58416/tests/dromaeo/cssquery-jquery.html) 14:28:54 INFO - PID 16804 | RSS: Main: 153456640 14:28:54 INFO - PID 16804 | 14:31:56 INFO - PID 16804 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58416/tests/dromaeo/cssquery-mootools.html) 14:31:57 INFO - PID 16804 | RSS: Main: 155103232 14:31:57 INFO - PID 16804 | 14:34:58 INFO - PID 16804 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58416/tests/dromaeo/cssquery-prototype.html) 14:34:59 INFO - PID 16804 | RSS: Main: 153845760 14:34:59 INFO - PID 16804 | 14:38:02 INFO - PID 16804 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58416/tests/dromaeo/cssquery-yui.html) 14:38:03 INFO - PID 16804 | RSS: Main: 155148288 14:38:03 INFO - PID 16804 | 14:41:04 INFO - PID 16804 | Cycle 1(1): loaded http://localhost:58416/tests/dromaeo/cssquery-yui.html (next: http://localhost:58416/tests/dromaeo/cssquery-dojo.html) 14:41:05 INFO - PID 16804 | RSS: Main: 157028352 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | __start_tp_report 14:41:05 INFO - PID 16804 | _x_x_mozilla_page_load 14:41:05 INFO - PID 16804 | _x_x_mozilla_page_load_details 14:41:05 INFO - PID 16804 | |i|pagename|runs| 14:41:05 INFO - PID 16804 | |0;dojo.html;3166.050184944517;3176.5235214717795;3177.3645270945817;3191.968080319196;3198.056573310873;6190.535709821759;6301.432871041606;6372.39462251086;6420.422162005419;6498.960166373381;6323.30443651198;6359.68201589921;6370.362963703639;6395.456386207166;6408.711607977641;5834.4165583441745;5836.5914385993;5857.238558987326;5866.237389139406;5920.733566989496;5888.941110588882;5889.322727886283;5928.614640048383;5930.55520835939;5959;5938.228030356047;5957.672328021957;5975.133605627181;5987.34139244685;6060.545459090564;5905.763769449217;5912.852178695567;5916.053431450969;5943.375945525722;5992.041273396236;5638.605297629168;5747.994101032303;5765.88468230633;5879.8530036749;5917;6377.872442551123;6385.968070159666;6431.517636177306;6447.742090316382;6475.611463312216;6667.26660067397;6728.293529179415;6744.730210791562;6819.488538359643;6861.622610756406;6777.220619628756;6799.082123913307;6837.076994605764;6844.349786770299;6859.588424694534;6424.196975378078;6461.386168314003;6464.547481676237;6464.676766161673;6468.579542329733;7039.472039597051;7053.4004609608755;7056.435485161175;7155.749548765768;7160.964195178991;6549.181352330958;6650.634215118118;6673.733050677918;6730.865382692319;6806.5235433520165;6763.256041835394;6845.247022827485;6865.41643960259;6914.308569143146;6922.930770692228;6765.898511522331;6789;6853.246142924274;6860.211075726255;6866.34769696878;6822.249552549216;6841.350071743176;6858.211305699809;6925;6936.132983377078;5398.64908780928;5402.35171779389;5402.810901618424;5407.324084489439;5421.132618781055;4701.7414042228;4748.715077095385;4752.073345697556;4784.186688263004;4787.234042553175;5824.912626310609;5830.82507524775;5836.241288632451;5907.172995780594;5910.290765108129;6696.5647232929705;6803.455723542104;6808.863822723518;6859.897101543481;6941.861162776817;5762.394948530427;5809.9419005809405;5833.212516310244;5858.560607954335;5868.501177399883;5792.768289268382;5795.9277533656405;5862.062070068769;5866.266716660418;5870.7945221917025;6427.710753016032;6474.0612611172055;6477.190351206099;6481.449076828522;6523.086767852505;6755.695993680296;6758.290379510081;6777.254502004677;6783.253842077269;6787.762428314985;6527.184101987252;6536.215654121345;6541.771038013647;6547.443467305332;6550.213974323112;6568.441682457044;6652.634105124071;6666.200055993312;6808.7276508939085;6844.076049733222;6853.965730171317;6898.482613803884;6939.063226464363;6943.479239057192;6947.548409353376;6617.1066905969;6631.171103612049;6631.767888123893;6724;6748.966255168692;6458;6548.3124271952665;6569.277379488348;6666.83332916681;6686.866262674816;6563.835904102436;6575.638339891352;6597.406233439014;6659.933400665931;6676;6670.666466676744;6674.8998765017595;6698;6746.392824645805;6779.6271205084195;6302.71637776292;6470.482361410982;6478;6586.176727909012;6590.308017658269 14:41:05 INFO - PID 16804 | |1;ext.html;861.1259571534891;862.9395942284035;863.2877875752506;864.3690106222457;885.2608072259662;40176.79911600442;40950.590494095086;44150.55849441505;44197.11605767887;44276.557234427644;40625;40888.38667419991;40965.385519217234;41049.38425923606;41051;7252.528585641943;7348.0447541819485;7363.77908662741;7388.630568471582;7968.920310796905;7986.321162701177;8094.9595252023655;8120.878186827203;8134.145914678962;8135.7152499662525;8091.878621820678;8149.592520373987;8168.019837619494;8168.509889406625;8171.387145964047;8076.4750291230885;8089.110197878229;8092.109867914524;8134.837303253931;8140.185981401872;7993.240642138988;8028.157043510406;8075.555844428554;8096.149904260085;8096.352291816641;38807.223855523014;39034.60965390338;39088.80455597732;39205;39270.803645981876;3546.308469848381;3546.769459985093;3578.534790477221;3583.4803953426867;3586.605473397924;31409.8429507851;31717;31719.365612687616;31726.524102138486;31740.365192696016;5091.516305950929;5260.316158899319;5308.177232528964;5343.679379237219;5367.114426119724;193099;194082;194418;194497.99999999857;194729;42537;48868.51131488711;49027.26459103116;49189.262161067614;49210.26184607234;44818;50167.49832501701;50630;50917;51138.488615113376;15532.145731984623;15646.452374166849;15695.529134125994;15696.76454853178;15709.371625135094;12836.80744788829;12871.613851584467;12872.678183045311;12873.356332183354;12873.935630321788;13590.660233494043;13743.656408589664;13792.448302068005;13853.099548529515;13918.373673184731;5655.745491452894;5706.771729130871;5717.999350113713;5724.513416359573;5823.417658234142;1011.4790882695418;1018.3686114608989;1027.4143738069229;1029.5418538750184;1031.633770011635;23332.53334933292;23418;23792.524149516914;23866.164684236315;24030.038798447866;1120.2214460949563;1124.8031594470935;1124.8931351521592;1126.267925848189;1140.0993215359938;12522.81215781764;12551.184173028907;12551.372431378395;12578.30819304947;12614.306213158181;230172;230192;231194;231214;232227;55554.44445555493;55739.721301393234;55765;55891.72054139703;56044.43955560474;1441.740486712381;1466.2041437935034;1472.374240947593;1484.2578710644677;1486.4425840309884;23032.884835575715;23238.1866634667;23299.417514562272;23502.177423790086;23531.41171470727;39135.2172956545;39195;39230.215395692496;39282;39509.80245098756;201942;203340;203376;203806;204093;34426.48360274548;34768;37850.43224351582;38615.80692096522;38681.41977870278;46242.76878615585;48131.75934120447;48587.75706121447;48611.5138848607;48931;34024;34327.4850877232;34583.13542161466;34679;34785.65214347824;33794.66205337915;34150.31699366048;34189.31621367509;34299.82850085734;34638.30723385569;36763.26473470462;38301.42547861728;38401.80799096098;38419.80790096032;38532.42201367038;32775.0167494966;33202.33595328128;33318.833405833786;33580;34019;24994.37514062163;25242;25367.873160634816;25455.74544254608;25867.482650347265 14:41:05 INFO - PID 16804 | |2;jquery.html;573.1832139201639;575.7150210645731;581.128307538692;589.8643312038232;620.7485968182887;22543.887280563595;23255.186068487605;23497.177598784045;23498.060077596874;23539.646905296435;23272.534549309046;24041.398965025885;24701.629475557882;24770.25689229326;24825.255242342715;6512.413882750551;6523.347665233486;6661.633610151464;6662.633555154464;6663.9333606663795;6523.086767852505;6624.403803657669;6627.403533681968;6639.668016599175;6833.794986150423;7117.964410177968;7190.604516751577;7192.4246060315045;7196.964015179917;7197.712091516333;7188.137423509186;7202.027726256941;7213.242609525977;7224.602646854395;7225.458090643197;6761.695723692445;6964.338387853146;7059.8588028239665;7064.187618423895;7066.470014748915;30383.544246836314;30723.231919201975;30932.0720378389;30994.0701778947;31195.128292302536;2092.3618296419586;2117.269542008005;2124.2034237161065;2133.7012818205308;2137.369476004567;20347;20626.17495300186;20926.162953481842;21017.474563135893;21058.368248952404;2556.7954563634867;2582.4447743735186;2619.8559079250635;2640.762331390165;2645.9206223813317;127099;132115.33942330227;140720;143293;149114;19513.707294390595;20372.38882833488;20941.288210152594;21376;21625.56748865014;42228.57771422308;42340.3648945266;42479.57520424818;42750.57249427466;42848;10495.26533142688;10531.947340263403;10554.153023221059;10777.137828973664;10810.135189185004;8690.478571285743;8733.38866279367;8792.60433280504;8816.955915220382;8831.60257788401;11033.889661103447;11232.213745037932;11248.775024499464;11249.550017999352;11619.941900290445;4185.351270553069;4326.242907491176;4431.601155895984;4504.9099018020115;4574.290984897346;946.432140715579;975.439297124595;979.5151400057017;989.2827699917646;996.7408473796866;18827.15277812502;19222.80777192238;19232.807671923383;19283.710744338845;19707.704384434244;1027.8304079826744;1031.828002055677;1038.9921775877388;1041.4324193314662;1052.3370276725766;10559.736006599896;10580.89419105799;10631.734206644896;10639.946800266103;10752.94623526893;511478;524028;531601;543115;551201;116846;118920;121378.39310803566;123023;123097;1036.259074761549;1080.346390433792;1090.825467925144;1139.646709520068;1147.162571322939;19762.70355944633;19830.702539462207;20219.797802021792;20276.79723202749;20441.38675839727;55296.72351638216;56494;57251.71374143103;57456.13815792683;58836.411635884804;68032;68202.3179768196;68209;68504.6574767123;68808.31191688219;19226.32707855218;19367.903160484108;19652.50868728293;19703.211871524978;19819;22233.888830555745;22425.775742242367;22628.547429051658;22766.20318288918;22847.08611655515;18124.637507250045;18272;18362.08189590542;18399.816001840347;18450.07749612487;16011.759823602422;16199;16543.91728041352;16714.832851671326;16955.321787128378;18117.818821811612;18326.450206493828;18390.264389424272;18572.721409178605;18654.160562774978;19098.23607055702;19149.808501914802;19190.90404548024;19224.903875480533;19304.903475482533;17621;18058.277668893097;18122.909385453517;18140.45578632643;18206.45380638583 14:41:05 INFO - PID 16804 | |3;mootools.html;1333.5199328241833;1397.0500059959236;1402.4250057476436;1410.5204230561608;1422.175138419716;15028.774568381483;15679.764803527927;15685.137317447536;15701.371945122195;15714.528564143095;15307.846921530781;15368.923155384235;15401.922990385061;15445.536633900972;15490.457833975785;2763.557830747086;2889.956650650242;2890.739833414992;2891.4361699468614;2894.667113281968;2716.171567671859;2858.35686970431;2866.3550701092295;2867.7992540522173;2873.0806142034558;2063.298478517304;2121.840861935361;2687.5296823055983;2792.9162125136177;2795.3151477887945;2768.8892444302205;2783.025940920682;2791.0510426455003;2793.916182514528;2804.4391121775725;2753.697093319753;2757.3244555083934;2761.1026416414747;2770.1966429735353;2786.303424143964;14815.925920370437;14951.551453456414;15012.249387530579;15018.399264029425;15031.398744050224;8185.672573097069;8452.492850428933;8490.108538603481;8494.830103397959;8496.192861678132;5244.685318880841;5398.216865069451;5509.146082357241;5570.080936645449;5601.803936862231;1927.9710804337947;1928.3154480159621;1951.5706544560173;1991.850611204151;2004.6491863923754;26501.734982650312;26705.332366690793;26746.465070698476;26791.732082679315;26826.731732682812;7190.101237345332;7484.738034168778;7491.475596708287;7614.847703046019;7669.884951725729;20447.897760511103;20556.383308500768;20558.897205513877;20580.691289630668;20592.794072059387;8418.789530261793;8567.74296771098;8571.828563428697;8575;8587.313014958789;7435.107787065586;7642.770716878503;7756.53460792343;7768.495047821873;7821.765347039598;5579.581531385163;5811.94188058114;5820.912686309709;5864.648121112747;6019.458248757545;1553.86015258625;1712.7516510105966;1733.5839398544258;1743.8692098092695;1800.4148651688254;728.8469421421561;887.5828360670474;891.6923661336829;898.4519443139679;905.6015353244551;8715.084916083846;8833.448741388005;8852.557372131369;8878.156575125353;8886.200241978124;1005.1355833982769;1006.1548299428515;1011.2163073618005;1011.9544620491948;1020.7193021918883;4715.174844402216;4734.26618874075;4779.713217206979;4822.927656085161;4873;21281.467963300733;22179;22276.108955641594;22308.219212327815;22310.330690079325;21064.157433702785;21826.672599911013;21838.89080554587;22138.44653883666;22300.21949231769;11863.940680296544;11941.880581194251;11968.341741204144;11977.281363118242;12010.579629712918;8347.791305217419;8510.957445212734;8629.913700862911;8656.740297791077;8774.780630484289;18857.057147142314;19039.57203209737;19307.324243651405;19542.413727588195;19764.505887352356;19544.413667589426;19597.412077637695;19727.309544165884;19816;20545;12327.630171094881;12374.381280935737;12486.063545233963;12492.312922789333;12578.811317830057;14136.293185340897;14170.645733856736;14276.21480818565;14288.214148221947;14295.92852035733;11602.361870097226;11685.883141168479;11737.295762254293;11753.294802311888;11998.64004079879;11290.266132701348;11636.94181529087;11665.24175928562;11783.234089784479;11899.524019039141;10385.584576616851;10515.78968420612;10536.631217907336;10536.841947370642;10536.84194737095;7299.890501642373;7393.297636724717;7403.777886663409;7420.740274090381;7479.775606731807;7370.410367170506;7372.225916278713;7405.111386633638;7407.296306850841;7568.205338439605 14:41:05 INFO - PID 16804 | |4;prototype.html;506.67572753437804;542.243570219544;543.334415341207;554.3763266325384;555.7026990560049;6437.485001199904;6438.205614946551;6499.740010399591;6540.247871494779;6546.509011824114;6214.5649804513705;6227;6239.750409983607;6352.714127864246;6379.17070780799;5041.495850414947;5143.177091665334;5239.266502689627;5247.763850626721;5274.129768588178;5118.181091025437;5162.767675454595;5178.171492561191;5202.297689811865;5210.16637338026;5071;5129.28190053391;5145.974270128644;5173.30160428343;5176.58587313016;5071.619628527857;5102.974485127587;5156.819511317123;5172.818951336722;5182.922256166161;4657.464391594942;4679.251319788817;4681.338124965656;4695.929561056587;4698.788554515055;6312.589681670676;6337.87324253517;6358.664680417118;6394.776182833625;6415.101885736;5816.2148110005455;5864.354920958691;5880.235929221217;5894.233749612523;5898.7640494380175;6661.902929698249;6680.665966701694;6681.331866813329;6711.328867113299;6733.9326606734285;5062.341895553592;5062.924056139161;5065.657600735808;5085.516421251455;5089.185730283137;6712.999999999951;6828.5902845829405;6981.3367730065565;6996.650167491605;7004.264552221944;5099.847004589868;5104.846854594368;5106.540411362995;5129.7178655173575;5140.742962851842;5123.129068058439;5149.433562308143;5153.227015947563;5153.299411194297;5179.067767801832;5747.137929310553;5768.134779783066;5803.7968671096305;5814.127880817911;5841.357450680422;6714.664266786641;6724.462043036546;6767.323267673193;6771.952621320425;6774.153230846145;1786.9635611345388;1787.8390944815028;1800.8649351298704;1805.6930321845318;1811.7463555102297;1167.5855071449682;1234.4753479771061;1237.56685160195;1251.5244207201206;1263.2041813657338;5661.915071273934;5681.204631351614;5769.394213607595;5790.247267855152;5805.8548536286935;6698.832529186712;6764;6837.897431538531;6862.210845752703;6934.821080416341;5579.302587176603;5651.491365777099;5793.391693872167;5794.8551286217335;5810.883782324415;3528.894133176009;3536.7701099428455;3548.201654627688;3548.520949671761;3612.710983121344;6419.903701444482;6502.6748662567625;6549.984752363392;6555.180602424697;6600.669966501656;6786.219584747719;6922.480813938874;6972.267911869282;6979.185411792971;7030.296970303031;6491.448226900767;6498.935010649833;6573.704183311763;6610.3720146586;6670.83322916931;6749.257581666111;6825.180978282638;6892.414144797748;6899.517033807585;6963.79108626742;6668.499862510428;6720.361565651256;6734.6632668367365;6891.552049116792;6943.305669433218;6442.677866106769;6490.3185165558825;6530.608163510205;6533.771318003847;6610.239822420291;5089.312942752681;5095.566876815512;5105.7191854448365;5128.05134049059;5156.948430515647;6667.566608170453;6714.429273511806;6818.28408017151;6963.303669632996;7010.826643740456;6607.2071351438135;6681.465482761465;6715.127033485615;6717.462602991846;6751.763688271083;6605.735770569124;6632.403083722488;6645.401913827779;6647.534672572873;6679.732810687518;6414.547634510629;6456.12842266288;6482.870342593216;6509.283978762427;6545.14913061318;6536.019597060479;6614.371634694697;6631.436327911989;6643.800685979429;6679.964605486158;6411.71147298382;6488.448481879093;6535.934640653532;6550.344965503412;6564.179477565304 14:41:05 INFO - PID 16804 | |5;yui.html;897.8339007283653;908.2370808520841;919.434547753132;924.727205474385;929.28909384321;19467.221311147554;20356.491087722796;20380.388588342335;20393.694094588594;20451.795482045174;17451.912740436313;17596.384126555575;17701.380451684192;18980.905095474503;19132.42602721917;966.0629189686011;980.9362391444533;983.6557204978236;983.9114479696826;984.0749695286444;961.9855702164438;980.5538479991623;981.1464026297132;982.1946004276496;983.2134292565954;1046.9947650261738;1047.3611097230682;1048.1038711901328;1048.5858086056003;1053.4679986606752;996.267743208741;1028.9125424338902;1033.194108595293;1036.1814166808213;1042.838360054193;747.249014740188;755.3466251692247;755.9811004724871;756.2362014365475;756.255088737593;20400.693989590167;20463.07916143777;20557.588848223102;20652.277170298967;20766.48083797902;20975.5804883903;21237.68143477849;21508.89245553762;21624.89187554052;21643;16641.916790416093;17056.744148837653;17265.22306496198;17346.13269336541;17388.47834564965;3764.4917936078555;3778.792166430845;3795.449659799341;3814.885553433374;3817;143708;144255.99999999895;145453.8181927272;147827;148838;16146.838531614769;16265.83734162667;16484.917575412284;16549.007059576463;16682.249298781582;30477.847610761804;30904.0728778137;31101.53347699786;31201;31266.218344541114;9174.220191283815;9175.403598766059;9330.066993300616;9381;9387.765305867408;4426.114777044604;4501.752403617833;4558.612517936012;4570.88572785683;4576.97711511447;5463.69949652765;5564.137558678412;5568.415316391802;5586.24585680936;5593.8321850344555;963.3738070254391;990.7572644702094;996.3274789517047;1005.6932635546228;1009.8283291840405;691.9792406227821;708.6456771614193;718.0163176448299;725.5646612032738;727.2364017781308;12296.262224266573;12601.55894543705;12650.620481385573;13350.265735384648;13430;670.580886945659;678.1116737074449;697.7348607529107;697.9720811167598;703.2896774258036;5264.868378290574;5266.131088370376;5279.366476022825;5338.492843179892;5361.035013697494;119966.4001679986;121440;121941;123450.38274808569;125447;106748.46625766977;107580.46209768901;108952.4552377233;111110;114966;90024;92092.53953730322;92549.53725231331;93761.53119234496;93861.5306923461;9352.953235233781;9556.904430955601;9656.37233579815;9702.563384647849;9747.561359738687;44969.32546011878;45120;45984.08031839278;46207.768961156326;46351.76824115858;58130;58246.70876645589;59376;59921;59999;15002.549923502313;15116.924415378293;15200.695986080438;15275.770863436835;15287.464938727091;17222.138893055548;17270.654586907942;17293;17405.82594174042;17430;15402.306896189475;15584.220788960733;15599.688006240038;15783.842161578697;15816.762748559011;14842.257887105385;14872.702545949236;14919.701605968037;15076.095434273979;15081.547553572971;14272.500462483764;14530.636734081732;14553.85446145525;14633.634159146106;14686.63283417923;11640.94179529097;11646.767064658829;11656.125790565911;11773.352465614473;11940.701482463008;12171.634850954486;12259.75480490403;12542.874571254535;12565.623031309075;12685.302308373128 14:41:05 INFO - PID 16804 | __end_tp_report 14:41:05 INFO - PID 16804 | __start_cc_report 14:41:05 INFO - PID 16804 | _x_x_mozilla_cycle_collect,294 14:41:05 INFO - PID 16804 | __end_cc_report 14:41:05 INFO - PID 16804 | __startTimestamp1506462065194__endTimestamp 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | ------- Summary: start ------- 14:41:05 INFO - PID 16804 | Number of tests: 6 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | [#0] dojo.html Cycles:165 Average:6278.90 Median:6498.96 stddev:747.93 (11.5%) stddev-sans-first:709.24 14:41:05 INFO - PID 16804 | Values: 3166.1 3176.5 3177.4 3192.0 3198.1 6190.5 6301.4 6372.4 6420.4 6499.0 6323.3 6359.7 6370.4 6395.5 6408.7 5834.4 5836.6 5857.2 5866.2 5920.7 5888.9 5889.3 5928.6 5930.6 5959.0 5938.2 5957.7 5975.1 5987.3 6060.5 5905.8 5912.9 5916.1 5943.4 5992.0 5638.6 5748.0 5765.9 5879.9 5917.0 6377.9 6386.0 6431.5 6447.7 6475.6 6667.3 6728.3 6744.7 6819.5 6861.6 6777.2 6799.1 6837.1 6844.3 6859.6 6424.2 6461.4 6464.5 6464.7 6468.6 7039.5 7053.4 7056.4 7155.7 7161.0 6549.2 6650.6 6673.7 6730.9 6806.5 6763.3 6845.2 6865.4 6914.3 6922.9 6765.9 6789.0 6853.2 6860.2 6866.3 6822.2 6841.4 6858.2 6925.0 6936.1 5398.6 5402.4 5402.8 5407.3 5421.1 4701.7 4748.7 4752.1 4784.2 4787.2 5824.9 5830.8 5836.2 5907.2 5910.3 6696.6 6803.5 6808.9 6859.9 6941.9 5762.4 5809.9 5833.2 5858.6 5868.5 5792.8 5795.9 5862.1 5866.3 5870.8 6427.7 6474.1 6477.2 6481.4 6523.1 6755.7 6758.3 6777.3 6783.3 6787.8 6527.2 6536.2 6541.8 6547.4 6550.2 6568.4 6652.6 6666.2 6808.7 6844.1 6854.0 6898.5 6939.1 6943.5 6947.5 6617.1 6631.2 6631.8 6724.0 6749.0 6458.0 6548.3 6569.3 6666.8 6686.9 6563.8 6575.6 6597.4 6659.9 6676.0 6670.7 6674.9 6698.0 6746.4 6779.6 6302.7 6470.5 6478.0 6586.2 6590.3 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | [#1] ext.html Cycles:180 Average:38515.89 Median:3585.04 stddev:54398.31 (1517.4%) stddev-sans-first:54477.44 14:41:05 INFO - PID 16804 | Values: 861.1 862.9 863.3 864.4 885.3 40176.8 40950.6 44150.6 44197.1 44276.6 40625.0 40888.4 40965.4 41049.4 41051.0 7252.5 7348.0 7363.8 7388.6 7968.9 7986.3 8095.0 8120.9 8134.1 8135.7 8091.9 8149.6 8168.0 8168.5 8171.4 8076.5 8089.1 8092.1 8134.8 8140.2 7993.2 8028.2 8075.6 8096.1 8096.4 38807.2 39034.6 39088.8 39205.0 39270.8 3546.3 3546.8 3578.5 3583.5 3586.6 31409.8 31717.0 31719.4 31726.5 31740.4 5091.5 5260.3 5308.2 5343.7 5367.1 193099.0 194082.0 194418.0 194498.0 194729.0 42537.0 48868.5 49027.3 49189.3 49210.3 44818.0 50167.5 50630.0 50917.0 51138.5 15532.1 15646.5 15695.5 15696.8 15709.4 12836.8 12871.6 12872.7 12873.4 12873.9 13590.7 13743.7 13792.4 13853.1 13918.4 5655.7 5706.8 5718.0 5724.5 5823.4 1011.5 1018.4 1027.4 1029.5 1031.6 23332.5 23418.0 23792.5 23866.2 24030.0 1120.2 1124.8 1124.9 1126.3 1140.1 12522.8 12551.2 12551.4 12578.3 12614.3 230172.0 230192.0 231194.0 231214.0 232227.0 55554.4 55739.7 55765.0 55891.7 56044.4 1441.7 1466.2 1472.4 1484.3 1486.4 23032.9 23238.2 23299.4 23502.2 23531.4 39135.2 39195.0 39230.2 39282.0 39509.8 201942.0 203340.0 203376.0 203806.0 204093.0 34426.5 34768.0 37850.4 38615.8 38681.4 46242.8 48131.8 48587.8 48611.5 48931.0 34024.0 34327.5 34583.1 34679.0 34785.7 33794.7 34150.3 34189.3 34299.8 34638.3 36763.3 38301.4 38401.8 38419.8 38532.4 32775.0 33202.3 33318.8 33580.0 34019.0 24994.4 25242.0 25367.9 25455.7 25867.5 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | [#2] jquery.html Cycles:180 Average:37224.12 Median:22329.83 stddev:89088.90 (399.0%) stddev-sans-first:89296.31 14:41:05 INFO - PID 16804 | Values: 573.2 575.7 581.1 589.9 620.7 22543.9 23255.2 23497.2 23498.1 23539.6 23272.5 24041.4 24701.6 24770.3 24825.3 6512.4 6523.3 6661.6 6662.6 6663.9 6523.1 6624.4 6627.4 6639.7 6833.8 7118.0 7190.6 7192.4 7197.0 7197.7 7188.1 7202.0 7213.2 7224.6 7225.5 6761.7 6964.3 7059.9 7064.2 7066.5 30383.5 30723.2 30932.1 30994.1 31195.1 2092.4 2117.3 2124.2 2133.7 2137.4 20347.0 20626.2 20926.2 21017.5 21058.4 2556.8 2582.4 2619.9 2640.8 2645.9 127099.0 132115.3 140720.0 143293.0 149114.0 19513.7 20372.4 20941.3 21376.0 21625.6 42228.6 42340.4 42479.6 42750.6 42848.0 10495.3 10531.9 10554.2 10777.1 10810.1 8690.5 8733.4 8792.6 8817.0 8831.6 11033.9 11232.2 11248.8 11249.6 11619.9 4185.4 4326.2 4431.6 4504.9 4574.3 946.4 975.4 979.5 989.3 996.7 18827.2 19222.8 19232.8 19283.7 19707.7 1027.8 1031.8 1039.0 1041.4 1052.3 10559.7 10580.9 10631.7 10639.9 10752.9 511478.0 524028.0 531601.0 543115.0 551201.0 116846.0 118920.0 121378.4 123023.0 123097.0 1036.3 1080.3 1090.8 1139.6 1147.2 19762.7 19830.7 20219.8 20276.8 20441.4 55296.7 56494.0 57251.7 57456.1 58836.4 68032.0 68202.3 68209.0 68504.7 68808.3 19226.3 19367.9 19652.5 19703.2 19819.0 22233.9 22425.8 22628.5 22766.2 22847.1 18124.6 18272.0 18362.1 18399.8 18450.1 16011.8 16199.0 16543.9 16714.8 16955.3 18117.8 18326.5 18390.3 18572.7 18654.2 19098.2 19149.8 19190.9 19224.9 19304.9 17621.0 18058.3 18122.9 18140.5 18206.5 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | [#3] mootools.html Cycles:180 Average:9720.40 Median:22309.27 stddev:6910.40 (31.0%) stddev-sans-first:6901.06 14:41:05 INFO - PID 16804 | Values: 1333.5 1397.1 1402.4 1410.5 1422.2 15028.8 15679.8 15685.1 15701.4 15714.5 15307.8 15368.9 15401.9 15445.5 15490.5 2763.6 2890.0 2890.7 2891.4 2894.7 2716.2 2858.4 2866.4 2867.8 2873.1 2063.3 2121.8 2687.5 2792.9 2795.3 2768.9 2783.0 2791.1 2793.9 2804.4 2753.7 2757.3 2761.1 2770.2 2786.3 14815.9 14951.6 15012.2 15018.4 15031.4 8185.7 8452.5 8490.1 8494.8 8496.2 5244.7 5398.2 5509.1 5570.1 5601.8 1928.0 1928.3 1951.6 1991.9 2004.6 26501.7 26705.3 26746.5 26791.7 26826.7 7190.1 7484.7 7491.5 7614.8 7669.9 20447.9 20556.4 20558.9 20580.7 20592.8 8418.8 8567.7 8571.8 8575.0 8587.3 7435.1 7642.8 7756.5 7768.5 7821.8 5579.6 5811.9 5820.9 5864.6 6019.5 1553.9 1712.8 1733.6 1743.9 1800.4 728.8 887.6 891.7 898.5 905.6 8715.1 8833.4 8852.6 8878.2 8886.2 1005.1 1006.2 1011.2 1012.0 1020.7 4715.2 4734.3 4779.7 4822.9 4873.0 21281.5 22179.0 22276.1 22308.2 22310.3 21064.2 21826.7 21838.9 22138.4 22300.2 11863.9 11941.9 11968.3 11977.3 12010.6 8347.8 8511.0 8629.9 8656.7 8774.8 18857.1 19039.6 19307.3 19542.4 19764.5 19544.4 19597.4 19727.3 19816.0 20545.0 12327.6 12374.4 12486.1 12492.3 12578.8 14136.3 14170.6 14276.2 14288.2 14295.9 11602.4 11685.9 11737.3 11753.3 11998.6 11290.3 11636.9 11665.2 11783.2 11899.5 10385.6 10515.8 10536.6 10536.8 10536.8 7299.9 7393.3 7403.8 7420.7 7479.8 7370.4 7372.2 7405.1 7407.3 7568.2 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | [#4] prototype.html Cycles:180 Average:5620.59 Median:6355.69 stddev:1564.38 (24.6%) stddev-sans-first:1520.95 14:41:05 INFO - PID 16804 | Values: 506.7 542.2 543.3 554.4 555.7 6437.5 6438.2 6499.7 6540.2 6546.5 6214.6 6227.0 6239.8 6352.7 6379.2 5041.5 5143.2 5239.3 5247.8 5274.1 5118.2 5162.8 5178.2 5202.3 5210.2 5071.0 5129.3 5146.0 5173.3 5176.6 5071.6 5103.0 5156.8 5172.8 5182.9 4657.5 4679.3 4681.3 4695.9 4698.8 6312.6 6337.9 6358.7 6394.8 6415.1 5816.2 5864.4 5880.2 5894.2 5898.8 6661.9 6680.7 6681.3 6711.3 6733.9 5062.3 5062.9 5065.7 5085.5 5089.2 6713.0 6828.6 6981.3 6996.7 7004.3 5099.8 5104.8 5106.5 5129.7 5140.7 5123.1 5149.4 5153.2 5153.3 5179.1 5747.1 5768.1 5803.8 5814.1 5841.4 6714.7 6724.5 6767.3 6772.0 6774.2 1787.0 1787.8 1800.9 1805.7 1811.7 1167.6 1234.5 1237.6 1251.5 1263.2 5661.9 5681.2 5769.4 5790.2 5805.9 6698.8 6764.0 6837.9 6862.2 6934.8 5579.3 5651.5 5793.4 5794.9 5810.9 3528.9 3536.8 3548.2 3548.5 3612.7 6419.9 6502.7 6550.0 6555.2 6600.7 6786.2 6922.5 6972.3 6979.2 7030.3 6491.4 6498.9 6573.7 6610.4 6670.8 6749.3 6825.2 6892.4 6899.5 6963.8 6668.5 6720.4 6734.7 6891.6 6943.3 6442.7 6490.3 6530.6 6533.8 6610.2 5089.3 5095.6 5105.7 5128.1 5156.9 6667.6 6714.4 6818.3 6963.3 7010.8 6607.2 6681.5 6715.1 6717.5 6751.8 6605.7 6632.4 6645.4 6647.5 6679.7 6414.5 6456.1 6482.9 6509.3 6545.1 6536.0 6614.4 6631.4 6643.8 6680.0 6411.7 6488.4 6535.9 6550.3 6564.2 14:41:05 INFO - PID 16804 | 14:41:05 INFO - PID 16804 | [#5] yui.html Cycles:180 Average:24483.53 Median:20871.03 stddev:35866.94 (171.9%) stddev-sans-first:35923.84 14:41:05 INFO - PID 16804 | Values: 897.8 908.2 919.4 924.7 929.3 19467.2 20356.5 20380.4 20393.7 20451.8 17451.9 17596.4 17701.4 18980.9 19132.4 966.1 980.9 983.7 983.9 984.1 962.0 980.6 981.1 982.2 983.2 1047.0 1047.4 1048.1 1048.6 1053.5 996.3 1028.9 1033.2 1036.2 1042.8 747.2 755.3 756.0 756.2 756.3 20400.7 20463.1 20557.6 20652.3 20766.5 20975.6 21237.7 21508.9 21624.9 21643.0 16641.9 17056.7 17265.2 17346.1 17388.5 3764.5 3778.8 3795.4 3814.9 3817.0 143708.0 144256.0 145453.8 147827.0 148838.0 16146.8 16265.8 16484.9 16549.0 16682.2 30477.8 30904.1 31101.5 31201.0 31266.2 9174.2 9175.4 9330.1 9381.0 9387.8 4426.1 4501.8 4558.6 4570.9 4577.0 5463.7 5564.1 5568.4 5586.2 5593.8 963.4 990.8 996.3 1005.7 1009.8 692.0 708.6 718.0 725.6 727.2 12296.3 12601.6 12650.6 13350.3 13430.0 670.6 678.1 697.7 698.0 703.3 5264.9 5266.1 5279.4 5338.5 5361.0 119966.4 121440.0 121941.0 123450.4 125447.0 106748.5 107580.5 108952.5 111110.0 114966.0 90024.0 92092.5 92549.5 93761.5 93861.5 9353.0 9556.9 9656.4 9702.6 9747.6 44969.3 45120.0 45984.1 46207.8 46351.8 58130.0 58246.7 59376.0 59921.0 59999.0 15002.5 15116.9 15200.7 15275.8 15287.5 17222.1 17270.7 17293.0 17405.8 17430.0 15402.3 15584.2 15599.7 15783.8 15816.8 14842.3 14872.7 14919.7 15076.1 15081.5 14272.5 14530.6 14553.9 14633.6 14686.6 11640.9 11646.8 11656.1 11773.4 11940.7 12171.6 12259.8 12542.9 12565.6 12685.3 14:41:05 INFO - PID 16804 | -------- Summary: end -------- 14:41:05 INFO - PID 16804 | 14:41:05 INFO - TEST-INFO | 16804: exit 0 14:41:05 INFO - TEST-OK | dromaeo_css | took 1109849ms 14:41:05 INFO - TEST-START | kraken 14:41:05 INFO - Initialising browser for kraken test... 14:41:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58416/getInfo.html -profile /tmp/tmpDT6bwz/profile 14:41:05 INFO - TEST-INFO | started process 17177 (/builds/slave/test/build/application/firefox/firefox http://localhost:58416/getInfo.html) 14:41:11 INFO - TEST-INFO | 17177: exit 0 14:41:11 INFO - Browser initialized. 14:41:11 INFO - Running cycle 1/1 for kraken test... 14:41:11 INFO - Using env: {'DISPLAY': ':0', 14:41:11 INFO - 'HOME': '/home/cltbld', 14:41:11 INFO - 'JSGC_DISABLE_POISONING': '1', 14:41:11 INFO - 'LANG': 'en_US.UTF-8', 14:41:11 INFO - 'LANGUAGE': 'en_US:en', 14:41:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:41:11 INFO - 'LOGNAME': 'cltbld', 14:41:11 INFO - 'MAIL': '/var/mail/cltbld', 14:41:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:41:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:41:11 INFO - 'MOZ_CRASHREPORTER': '1', 14:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:41:11 INFO - 'MOZ_NO_REMOTE': '1', 14:41:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:11 INFO - 'NO_EM_RESTART': '1', 14:41:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:11 INFO - 'PWD': '/builds/slave/test', 14:41:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:41:11 INFO - 'RUST_BACKTRACE': 'full', 14:41:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:41:11 INFO - 'SHELL': '/bin/bash', 14:41:11 INFO - 'SHLVL': '1', 14:41:11 INFO - 'TERM': 'linux', 14:41:11 INFO - 'TMOUT': '86400', 14:41:11 INFO - 'USER': 'cltbld', 14:41:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714', 14:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:11 INFO - '_': '/tools/buildbot/bin/python'} 14:41:11 INFO - TEST-INFO | started process 17410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDT6bwz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:12 INFO - PID 17410 | 14:41:12 INFO - PID 17410 | (/builds/slave/test/build/application/firefox/firefox:17460): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:41:12 INFO - PID 17410 | 14:41:22 INFO - PID 17410 | RSS: Main: 153337856 14:41:22 INFO - PID 17410 | 14:41:25 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:25 INFO - PID 17410 | RSS: Main: 160411648 14:41:25 INFO - PID 17410 | 14:41:28 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-dft) 14:41:29 INFO - PID 17410 | RSS: Main: 160370688 14:41:29 INFO - PID 17410 | 14:41:32 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-fft) 14:41:32 INFO - PID 17410 | RSS: Main: 156479488 14:41:32 INFO - PID 17410 | 14:41:35 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58416/tests/kraken/driver.html?testName=audio-oscillator) 14:41:35 INFO - PID 17410 | RSS: Main: 156618752 14:41:35 INFO - PID 17410 | 14:41:37 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:38 INFO - PID 17410 | RSS: Main: 156831744 14:41:38 INFO - PID 17410 | 14:41:41 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58416/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:42 INFO - PID 17410 | RSS: Main: 159383552 14:41:42 INFO - PID 17410 | 14:41:45 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58416/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:46 INFO - PID 17410 | RSS: Main: 158965760 14:41:46 INFO - PID 17410 | 14:41:49 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58416/tests/kraken/driver.html?testName=json-parse-financial) 14:41:50 INFO - PID 17410 | RSS: Main: 159330304 14:41:50 INFO - PID 17410 | 14:41:51 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:52 INFO - PID 17410 | RSS: Main: 158945280 14:41:52 INFO - PID 17410 | 14:41:53 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:54 INFO - PID 17410 | RSS: Main: 159309824 14:41:54 INFO - PID 17410 | 14:41:56 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:57 INFO - PID 17410 | RSS: Main: 155975680 14:41:57 INFO - PID 17410 | 14:41:59 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:00 INFO - PID 17410 | RSS: Main: 156905472 14:42:00 INFO - PID 17410 | 14:42:03 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:03 INFO - PID 17410 | RSS: Main: 156688384 14:42:03 INFO - PID 17410 | 14:42:05 INFO - PID 17410 | Cycle 1(1): loaded http://localhost:58416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58416/tests/kraken/driver.html?testName=ai-astar) 14:42:06 INFO - PID 17410 | RSS: Main: 158498816 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | __start_tp_report 14:42:06 INFO - PID 17410 | _x_x_mozilla_page_load 14:42:06 INFO - PID 17410 | _x_x_mozilla_page_load_details 14:42:06 INFO - PID 17410 | |i|pagename|runs| 14:42:06 INFO - PID 17410 | |0;ai-astar;108;108;107;109;110;109;109;107;108;108 14:42:06 INFO - PID 17410 | |1;audio-beat-detection;132;119;119;118;118;116;118;119;126;117 14:42:06 INFO - PID 17410 | |2;audio-dft;162;163;162;164;162;162;165;164;167;165 14:42:06 INFO - PID 17410 | |3;audio-fft;76;75;75;74;75;76;75;75;75;75 14:42:06 INFO - PID 17410 | |4;audio-oscillator;81;82;78;79;78;79;79;80;80;78 14:42:06 INFO - PID 17410 | |5;imaging-gaussian-blur;110;113;114;113;113;113;113;114;115;114 14:42:06 INFO - PID 17410 | |6;imaging-darkroom;149;147;148;149;148;150;149;149;148;149 14:42:06 INFO - PID 17410 | |7;imaging-desaturate;95;94;94;94;95;94;99;94;94;94 14:42:06 INFO - PID 17410 | |8;json-parse-financial;53;54;52;52;55;54;54;53;54;53 14:42:06 INFO - PID 17410 | |9;json-stringify-tinderbox;38;38;37;38;38;38;38;38;38;38 14:42:06 INFO - PID 17410 | |10;stanford-crypto-aes;77;74;77;72;72;74;75;72;75;75 14:42:06 INFO - PID 17410 | |11;stanford-crypto-ccm;113;108;112;110;111;112;111;109;117;115 14:42:06 INFO - PID 17410 | |12;stanford-crypto-pbkdf2;170;167;163;173;168;181;169;165;164;174 14:42:06 INFO - PID 17410 | |13;stanford-crypto-sha256-iterative;69;76;69;70;64;69;66;67;74;66 14:42:06 INFO - PID 17410 | __end_tp_report 14:42:06 INFO - PID 17410 | __start_cc_report 14:42:06 INFO - PID 17410 | _x_x_mozilla_cycle_collect,727 14:42:06 INFO - PID 17410 | __end_cc_report 14:42:06 INFO - PID 17410 | __startTimestamp1506462126039__endTimestamp 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | ------- Summary: start ------- 14:42:06 INFO - PID 17410 | Number of tests: 14 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#0] ai-astar Cycles:10 Average:108.30 Median:108.50 stddev:0.95 (0.9%) stddev-sans-first:1.00 14:42:06 INFO - PID 17410 | Values: 108.0 108.0 107.0 109.0 110.0 109.0 109.0 107.0 108.0 108.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:119.00 stddev:4.94 (4.2%) stddev-sans-first:2.85 14:42:06 INFO - PID 17410 | Values: 132.0 119.0 119.0 118.0 118.0 116.0 118.0 119.0 126.0 117.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.71 (1.0%) stddev-sans-first:1.72 14:42:06 INFO - PID 17410 | Values: 162.0 163.0 162.0 164.0 162.0 162.0 165.0 164.0 167.0 165.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 14:42:06 INFO - PID 17410 | Values: 76.0 75.0 75.0 74.0 75.0 76.0 75.0 75.0 75.0 75.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:1.35 (1.7%) stddev-sans-first:1.30 14:42:06 INFO - PID 17410 | Values: 81.0 82.0 78.0 79.0 78.0 79.0 79.0 80.0 80.0 78.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.50 stddev:1.32 (1.2%) stddev-sans-first:0.73 14:42:06 INFO - PID 17410 | Values: 110.0 113.0 114.0 113.0 113.0 113.0 113.0 114.0 115.0 114.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 14:42:06 INFO - PID 17410 | Values: 149.0 147.0 148.0 149.0 148.0 150.0 149.0 149.0 148.0 149.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.66 14:42:06 INFO - PID 17410 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 99.0 94.0 94.0 94.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 14:42:06 INFO - PID 17410 | Values: 53.0 54.0 52.0 52.0 55.0 54.0 54.0 53.0 54.0 53.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 14:42:06 INFO - PID 17410 | Values: 38.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:75.00 stddev:1.89 (2.5%) stddev-sans-first:1.73 14:42:06 INFO - PID 17410 | Values: 77.0 74.0 77.0 72.0 72.0 74.0 75.0 72.0 75.0 75.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:112.00 stddev:2.70 (2.4%) stddev-sans-first:2.83 14:42:06 INFO - PID 17410 | Values: 113.0 108.0 112.0 110.0 111.0 112.0 111.0 109.0 117.0 115.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:5.44 (3.2%) stddev-sans-first:5.77 14:42:06 INFO - PID 17410 | Values: 170.0 167.0 163.0 173.0 168.0 181.0 169.0 165.0 164.0 174.0 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:3.68 (5.3%) stddev-sans-first:3.91 14:42:06 INFO - PID 17410 | Values: 69.0 76.0 69.0 70.0 64.0 69.0 66.0 67.0 74.0 66.0 14:42:06 INFO - PID 17410 | -------- Summary: end -------- 14:42:06 INFO - PID 17410 | 14:42:06 INFO - PID 17410 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:42:06 INFO - TEST-INFO | 17410: exit 0 14:42:06 INFO - TEST-OK | kraken | took 60817ms 14:42:06 INFO - SUITE-END | took 1170s 14:42:06 INFO - Completed test suite (00:19:30) 14:42:06 INFO - javascript benchmark 14:42:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8764.681755301737, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.050184944517, 3176.5235214717795, 3177.3645270945817, 3191.968080319196, 3198.056573310873, 6190.535709821759, 6301.432871041606, 6372.39462251086, 6420.422162005419, 6498.960166373381, 6323.30443651198, 6359.68201589921, 6370.362963703639, 6395.456386207166, 6408.711607977641, 5834.4165583441745, 5836.5914385993, 5857.238558987326, 5866.237389139406, 5920.733566989496, 5888.941110588882, 5889.322727886283, 5928.614640048383, 5930.55520835939, 5959.0, 5938.228030356047, 5957.672328021957, 5975.133605627181, 5987.34139244685, 6060.545459090564, 5905.763769449217, 5912.852178695567, 5916.053431450969, 5943.375945525722, 5992.041273396236, 5638.605297629168, 5747.994101032303, 5765.88468230633, 5879.8530036749, 5917.0, 6377.872442551123, 6385.968070159666, 6431.517636177306, 6447.742090316382, 6475.611463312216, 6667.26660067397, 6728.293529179415, 6744.730210791562, 6819.488538359643, 6861.622610756406, 6777.220619628756, 6799.082123913307, 6837.076994605764, 6844.349786770299, 6859.588424694534, 6424.196975378078, 6461.386168314003, 6464.547481676237, 6464.676766161673, 6468.579542329733, 7039.472039597051, 7053.4004609608755, 7056.435485161175, 7155.749548765768, 7160.964195178991, 6549.181352330958, 6650.634215118118, 6673.733050677918, 6730.865382692319, 6806.5235433520165, 6763.256041835394, 6845.247022827485, 6865.41643960259, 6914.308569143146, 6922.930770692228, 6765.898511522331, 6789.0, 6853.246142924274, 6860.211075726255, 6866.34769696878, 6822.249552549216, 6841.350071743176, 6858.211305699809, 6925.0, 6936.132983377078, 5398.64908780928, 5402.35171779389, 5402.810901618424, 5407.324084489439, 5421.132618781055, 4701.7414042228, 4748.715077095385, 4752.073345697556, 4784.186688263004, 4787.234042553175, 5824.912626310609, 5830.82507524775, 5836.241288632451, 5907.172995780594, 5910.290765108129, 6696.5647232929705, 6803.455723542104, 6808.863822723518, 6859.897101543481, 6941.861162776817, 5762.394948530427, 5809.9419005809405, 5833.212516310244, 5858.560607954335, 5868.501177399883, 5792.768289268382, 5795.9277533656405, 5862.062070068769, 5866.266716660418, 5870.7945221917025, 6427.710753016032, 6474.0612611172055, 6477.190351206099, 6481.449076828522, 6523.086767852505, 6755.695993680296, 6758.290379510081, 6777.254502004677, 6783.253842077269, 6787.762428314985, 6527.184101987252, 6536.215654121345, 6541.771038013647, 6547.443467305332, 6550.213974323112, 6568.441682457044, 6652.634105124071, 6666.200055993312, 6808.7276508939085, 6844.076049733222, 6853.965730171317, 6898.482613803884, 6939.063226464363, 6943.479239057192, 6947.548409353376, 6617.1066905969, 6631.171103612049, 6631.767888123893, 6724.0, 6748.966255168692, 6458.0, 6548.3124271952665, 6569.277379488348, 6666.83332916681, 6686.866262674816, 6563.835904102436, 6575.638339891352, 6597.406233439014, 6659.933400665931, 6676.0, 6670.666466676744, 6674.8998765017595, 6698.0, 6746.392824645805, 6779.6271205084195, 6302.71637776292, 6470.482361410982, 6478.0, 6586.176727909012, 6590.308017658269], "value": 6221.908151948062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.1259571534891, 862.9395942284035, 863.2877875752506, 864.3690106222457, 885.2608072259662, 40176.79911600442, 40950.590494095086, 44150.55849441505, 44197.11605767887, 44276.557234427644, 40625.0, 40888.38667419991, 40965.385519217234, 41049.38425923606, 41051.0, 7252.528585641943, 7348.0447541819485, 7363.77908662741, 7388.630568471582, 7968.920310796905, 7986.321162701177, 8094.9595252023655, 8120.878186827203, 8134.145914678962, 8135.7152499662525, 8091.878621820678, 8149.592520373987, 8168.019837619494, 8168.509889406625, 8171.387145964047, 8076.4750291230885, 8089.110197878229, 8092.109867914524, 8134.837303253931, 8140.185981401872, 7993.240642138988, 8028.157043510406, 8075.555844428554, 8096.149904260085, 8096.352291816641, 38807.223855523014, 39034.60965390338, 39088.80455597732, 39205.0, 39270.803645981876, 3546.308469848381, 3546.769459985093, 3578.534790477221, 3583.4803953426867, 3586.605473397924, 31409.8429507851, 31717.0, 31719.365612687616, 31726.524102138486, 31740.365192696016, 5091.516305950929, 5260.316158899319, 5308.177232528964, 5343.679379237219, 5367.114426119724, 193099.0, 194082.0, 194418.0, 194497.99999999857, 194729.0, 42537.0, 48868.51131488711, 49027.26459103116, 49189.262161067614, 49210.26184607234, 44818.0, 50167.49832501701, 50630.0, 50917.0, 51138.488615113376, 15532.145731984623, 15646.452374166849, 15695.529134125994, 15696.76454853178, 15709.371625135094, 12836.80744788829, 12871.613851584467, 12872.678183045311, 12873.356332183354, 12873.935630321788, 13590.660233494043, 13743.656408589664, 13792.448302068005, 13853.099548529515, 13918.373673184731, 5655.745491452894, 5706.771729130871, 5717.999350113713, 5724.513416359573, 5823.417658234142, 1011.4790882695418, 1018.3686114608989, 1027.4143738069229, 1029.5418538750184, 1031.633770011635, 23332.53334933292, 23418.0, 23792.524149516914, 23866.164684236315, 24030.038798447866, 1120.2214460949563, 1124.8031594470935, 1124.8931351521592, 1126.267925848189, 1140.0993215359938, 12522.81215781764, 12551.184173028907, 12551.372431378395, 12578.30819304947, 12614.306213158181, 230172.0, 230192.0, 231194.0, 231214.0, 232227.0, 55554.44445555493, 55739.721301393234, 55765.0, 55891.72054139703, 56044.43955560474, 1441.740486712381, 1466.2041437935034, 1472.374240947593, 1484.2578710644677, 1486.4425840309884, 23032.884835575715, 23238.1866634667, 23299.417514562272, 23502.177423790086, 23531.41171470727, 39135.2172956545, 39195.0, 39230.215395692496, 39282.0, 39509.80245098756, 201942.0, 203340.0, 203376.0, 203806.0, 204093.0, 34426.48360274548, 34768.0, 37850.43224351582, 38615.80692096522, 38681.41977870278, 46242.76878615585, 48131.75934120447, 48587.75706121447, 48611.5138848607, 48931.0, 34024.0, 34327.4850877232, 34583.13542161466, 34679.0, 34785.65214347824, 33794.66205337915, 34150.31699366048, 34189.31621367509, 34299.82850085734, 34638.30723385569, 36763.26473470462, 38301.42547861728, 38401.80799096098, 38419.80790096032, 38532.42201367038, 32775.0167494966, 33202.33595328128, 33318.833405833786, 33580.0, 34019.0, 24994.37514062163, 25242.0, 25367.873160634816, 25455.74544254608, 25867.482650347265], "value": 17594.265224365103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1832139201639, 575.7150210645731, 581.128307538692, 589.8643312038232, 620.7485968182887, 22543.887280563595, 23255.186068487605, 23497.177598784045, 23498.060077596874, 23539.646905296435, 23272.534549309046, 24041.398965025885, 24701.629475557882, 24770.25689229326, 24825.255242342715, 6512.413882750551, 6523.347665233486, 6661.633610151464, 6662.633555154464, 6663.9333606663795, 6523.086767852505, 6624.403803657669, 6627.403533681968, 6639.668016599175, 6833.794986150423, 7117.964410177968, 7190.604516751577, 7192.4246060315045, 7196.964015179917, 7197.712091516333, 7188.137423509186, 7202.027726256941, 7213.242609525977, 7224.602646854395, 7225.458090643197, 6761.695723692445, 6964.338387853146, 7059.8588028239665, 7064.187618423895, 7066.470014748915, 30383.544246836314, 30723.231919201975, 30932.0720378389, 30994.0701778947, 31195.128292302536, 2092.3618296419586, 2117.269542008005, 2124.2034237161065, 2133.7012818205308, 2137.369476004567, 20347.0, 20626.17495300186, 20926.162953481842, 21017.474563135893, 21058.368248952404, 2556.7954563634867, 2582.4447743735186, 2619.8559079250635, 2640.762331390165, 2645.9206223813317, 127099.0, 132115.33942330227, 140720.0, 143293.0, 149114.0, 19513.707294390595, 20372.38882833488, 20941.288210152594, 21376.0, 21625.56748865014, 42228.57771422308, 42340.3648945266, 42479.57520424818, 42750.57249427466, 42848.0, 10495.26533142688, 10531.947340263403, 10554.153023221059, 10777.137828973664, 10810.135189185004, 8690.478571285743, 8733.38866279367, 8792.60433280504, 8816.955915220382, 8831.60257788401, 11033.889661103447, 11232.213745037932, 11248.775024499464, 11249.550017999352, 11619.941900290445, 4185.351270553069, 4326.242907491176, 4431.601155895984, 4504.9099018020115, 4574.290984897346, 946.432140715579, 975.439297124595, 979.5151400057017, 989.2827699917646, 996.7408473796866, 18827.15277812502, 19222.80777192238, 19232.807671923383, 19283.710744338845, 19707.704384434244, 1027.8304079826744, 1031.828002055677, 1038.9921775877388, 1041.4324193314662, 1052.3370276725766, 10559.736006599896, 10580.89419105799, 10631.734206644896, 10639.946800266103, 10752.94623526893, 511478.0, 524028.0, 531601.0, 543115.0, 551201.0, 116846.0, 118920.0, 121378.39310803566, 123023.0, 123097.0, 1036.259074761549, 1080.346390433792, 1090.825467925144, 1139.646709520068, 1147.162571322939, 19762.70355944633, 19830.702539462207, 20219.797802021792, 20276.79723202749, 20441.38675839727, 55296.72351638216, 56494.0, 57251.71374143103, 57456.13815792683, 58836.411635884804, 68032.0, 68202.3179768196, 68209.0, 68504.6574767123, 68808.31191688219, 19226.32707855218, 19367.903160484108, 19652.50868728293, 19703.211871524978, 19819.0, 22233.888830555745, 22425.775742242367, 22628.547429051658, 22766.20318288918, 22847.08611655515, 18124.637507250045, 18272.0, 18362.08189590542, 18399.816001840347, 18450.07749612487, 16011.759823602422, 16199.0, 16543.91728041352, 16714.832851671326, 16955.321787128378, 18117.818821811612, 18326.450206493828, 18390.264389424272, 18572.721409178605, 18654.160562774978, 19098.23607055702, 19149.808501914802, 19190.90404548024, 19224.903875480533, 19304.903475482533, 17621.0, 18058.277668893097, 18122.909385453517, 18140.45578632643, 18206.45380638583], "value": 12930.877980443689, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.5199328241833, 1397.0500059959236, 1402.4250057476436, 1410.5204230561608, 1422.175138419716, 15028.774568381483, 15679.764803527927, 15685.137317447536, 15701.371945122195, 15714.528564143095, 15307.846921530781, 15368.923155384235, 15401.922990385061, 15445.536633900972, 15490.457833975785, 2763.557830747086, 2889.956650650242, 2890.739833414992, 2891.4361699468614, 2894.667113281968, 2716.171567671859, 2858.35686970431, 2866.3550701092295, 2867.7992540522173, 2873.0806142034558, 2063.298478517304, 2121.840861935361, 2687.5296823055983, 2792.9162125136177, 2795.3151477887945, 2768.8892444302205, 2783.025940920682, 2791.0510426455003, 2793.916182514528, 2804.4391121775725, 2753.697093319753, 2757.3244555083934, 2761.1026416414747, 2770.1966429735353, 2786.303424143964, 14815.925920370437, 14951.551453456414, 15012.249387530579, 15018.399264029425, 15031.398744050224, 8185.672573097069, 8452.492850428933, 8490.108538603481, 8494.830103397959, 8496.192861678132, 5244.685318880841, 5398.216865069451, 5509.146082357241, 5570.080936645449, 5601.803936862231, 1927.9710804337947, 1928.3154480159621, 1951.5706544560173, 1991.850611204151, 2004.6491863923754, 26501.734982650312, 26705.332366690793, 26746.465070698476, 26791.732082679315, 26826.731732682812, 7190.101237345332, 7484.738034168778, 7491.475596708287, 7614.847703046019, 7669.884951725729, 20447.897760511103, 20556.383308500768, 20558.897205513877, 20580.691289630668, 20592.794072059387, 8418.789530261793, 8567.74296771098, 8571.828563428697, 8575.0, 8587.313014958789, 7435.107787065586, 7642.770716878503, 7756.53460792343, 7768.495047821873, 7821.765347039598, 5579.581531385163, 5811.94188058114, 5820.912686309709, 5864.648121112747, 6019.458248757545, 1553.86015258625, 1712.7516510105966, 1733.5839398544258, 1743.8692098092695, 1800.4148651688254, 728.8469421421561, 887.5828360670474, 891.6923661336829, 898.4519443139679, 905.6015353244551, 8715.084916083846, 8833.448741388005, 8852.557372131369, 8878.156575125353, 8886.200241978124, 1005.1355833982769, 1006.1548299428515, 1011.2163073618005, 1011.9544620491948, 1020.7193021918883, 4715.174844402216, 4734.26618874075, 4779.713217206979, 4822.927656085161, 4873.0, 21281.467963300733, 22179.0, 22276.108955641594, 22308.219212327815, 22310.330690079325, 21064.157433702785, 21826.672599911013, 21838.89080554587, 22138.44653883666, 22300.21949231769, 11863.940680296544, 11941.880581194251, 11968.341741204144, 11977.281363118242, 12010.579629712918, 8347.791305217419, 8510.957445212734, 8629.913700862911, 8656.740297791077, 8774.780630484289, 18857.057147142314, 19039.57203209737, 19307.324243651405, 19542.413727588195, 19764.505887352356, 19544.413667589426, 19597.412077637695, 19727.309544165884, 19816.0, 20545.0, 12327.630171094881, 12374.381280935737, 12486.063545233963, 12492.312922789333, 12578.811317830057, 14136.293185340897, 14170.645733856736, 14276.21480818565, 14288.214148221947, 14295.92852035733, 11602.361870097226, 11685.883141168479, 11737.295762254293, 11753.294802311888, 11998.64004079879, 11290.266132701348, 11636.94181529087, 11665.24175928562, 11783.234089784479, 11899.524019039141, 10385.584576616851, 10515.78968420612, 10536.631217907336, 10536.841947370642, 10536.84194737095, 7299.890501642373, 7393.297636724717, 7403.777886663409, 7420.740274090381, 7479.775606731807, 7370.410367170506, 7372.225916278713, 7405.111386633638, 7407.296306850841, 7568.205338439605], "value": 6930.9958739336425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.67572753437804, 542.243570219544, 543.334415341207, 554.3763266325384, 555.7026990560049, 6437.485001199904, 6438.205614946551, 6499.740010399591, 6540.247871494779, 6546.509011824114, 6214.5649804513705, 6227.0, 6239.750409983607, 6352.714127864246, 6379.17070780799, 5041.495850414947, 5143.177091665334, 5239.266502689627, 5247.763850626721, 5274.129768588178, 5118.181091025437, 5162.767675454595, 5178.171492561191, 5202.297689811865, 5210.16637338026, 5071.0, 5129.28190053391, 5145.974270128644, 5173.30160428343, 5176.58587313016, 5071.619628527857, 5102.974485127587, 5156.819511317123, 5172.818951336722, 5182.922256166161, 4657.464391594942, 4679.251319788817, 4681.338124965656, 4695.929561056587, 4698.788554515055, 6312.589681670676, 6337.87324253517, 6358.664680417118, 6394.776182833625, 6415.101885736, 5816.2148110005455, 5864.354920958691, 5880.235929221217, 5894.233749612523, 5898.7640494380175, 6661.902929698249, 6680.665966701694, 6681.331866813329, 6711.328867113299, 6733.9326606734285, 5062.341895553592, 5062.924056139161, 5065.657600735808, 5085.516421251455, 5089.185730283137, 6712.999999999951, 6828.5902845829405, 6981.3367730065565, 6996.650167491605, 7004.264552221944, 5099.847004589868, 5104.846854594368, 5106.540411362995, 5129.7178655173575, 5140.742962851842, 5123.129068058439, 5149.433562308143, 5153.227015947563, 5153.299411194297, 5179.067767801832, 5747.137929310553, 5768.134779783066, 5803.7968671096305, 5814.127880817911, 5841.357450680422, 6714.664266786641, 6724.462043036546, 6767.323267673193, 6771.952621320425, 6774.153230846145, 1786.9635611345388, 1787.8390944815028, 1800.8649351298704, 1805.6930321845318, 1811.7463555102297, 1167.5855071449682, 1234.4753479771061, 1237.56685160195, 1251.5244207201206, 1263.2041813657338, 5661.915071273934, 5681.204631351614, 5769.394213607595, 5790.247267855152, 5805.8548536286935, 6698.832529186712, 6764.0, 6837.897431538531, 6862.210845752703, 6934.821080416341, 5579.302587176603, 5651.491365777099, 5793.391693872167, 5794.8551286217335, 5810.883782324415, 3528.894133176009, 3536.7701099428455, 3548.201654627688, 3548.520949671761, 3612.710983121344, 6419.903701444482, 6502.6748662567625, 6549.984752363392, 6555.180602424697, 6600.669966501656, 6786.219584747719, 6922.480813938874, 6972.267911869282, 6979.185411792971, 7030.296970303031, 6491.448226900767, 6498.935010649833, 6573.704183311763, 6610.3720146586, 6670.83322916931, 6749.257581666111, 6825.180978282638, 6892.414144797748, 6899.517033807585, 6963.79108626742, 6668.499862510428, 6720.361565651256, 6734.6632668367365, 6891.552049116792, 6943.305669433218, 6442.677866106769, 6490.3185165558825, 6530.608163510205, 6533.771318003847, 6610.239822420291, 5089.312942752681, 5095.566876815512, 5105.7191854448365, 5128.05134049059, 5156.948430515647, 6667.566608170453, 6714.429273511806, 6818.28408017151, 6963.303669632996, 7010.826643740456, 6607.2071351438135, 6681.465482761465, 6715.127033485615, 6717.462602991846, 6751.763688271083, 6605.735770569124, 6632.403083722488, 6645.401913827779, 6647.534672572873, 6679.732810687518, 6414.547634510629, 6456.12842266288, 6482.870342593216, 6509.283978762427, 6545.14913061318, 6536.019597060479, 6614.371634694697, 6631.436327911989, 6643.800685979429, 6679.964605486158, 6411.71147298382, 6488.448481879093, 6535.934640653532, 6550.344965503412, 6564.179477565304], "value": 5162.137273043293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.8339007283653, 908.2370808520841, 919.434547753132, 924.727205474385, 929.28909384321, 19467.221311147554, 20356.491087722796, 20380.388588342335, 20393.694094588594, 20451.795482045174, 17451.912740436313, 17596.384126555575, 17701.380451684192, 18980.905095474503, 19132.42602721917, 966.0629189686011, 980.9362391444533, 983.6557204978236, 983.9114479696826, 984.0749695286444, 961.9855702164438, 980.5538479991623, 981.1464026297132, 982.1946004276496, 983.2134292565954, 1046.9947650261738, 1047.3611097230682, 1048.1038711901328, 1048.5858086056003, 1053.4679986606752, 996.267743208741, 1028.9125424338902, 1033.194108595293, 1036.1814166808213, 1042.838360054193, 747.249014740188, 755.3466251692247, 755.9811004724871, 756.2362014365475, 756.255088737593, 20400.693989590167, 20463.07916143777, 20557.588848223102, 20652.277170298967, 20766.48083797902, 20975.5804883903, 21237.68143477849, 21508.89245553762, 21624.89187554052, 21643.0, 16641.916790416093, 17056.744148837653, 17265.22306496198, 17346.13269336541, 17388.47834564965, 3764.4917936078555, 3778.792166430845, 3795.449659799341, 3814.885553433374, 3817.0, 143708.0, 144255.99999999895, 145453.8181927272, 147827.0, 148838.0, 16146.838531614769, 16265.83734162667, 16484.917575412284, 16549.007059576463, 16682.249298781582, 30477.847610761804, 30904.0728778137, 31101.53347699786, 31201.0, 31266.218344541114, 9174.220191283815, 9175.403598766059, 9330.066993300616, 9381.0, 9387.765305867408, 4426.114777044604, 4501.752403617833, 4558.612517936012, 4570.88572785683, 4576.97711511447, 5463.69949652765, 5564.137558678412, 5568.415316391802, 5586.24585680936, 5593.8321850344555, 963.3738070254391, 990.7572644702094, 996.3274789517047, 1005.6932635546228, 1009.8283291840405, 691.9792406227821, 708.6456771614193, 718.0163176448299, 725.5646612032738, 727.2364017781308, 12296.262224266573, 12601.55894543705, 12650.620481385573, 13350.265735384648, 13430.0, 670.580886945659, 678.1116737074449, 697.7348607529107, 697.9720811167598, 703.2896774258036, 5264.868378290574, 5266.131088370376, 5279.366476022825, 5338.492843179892, 5361.035013697494, 119966.4001679986, 121440.0, 121941.0, 123450.38274808569, 125447.0, 106748.46625766977, 107580.46209768901, 108952.4552377233, 111110.0, 114966.0, 90024.0, 92092.53953730322, 92549.53725231331, 93761.53119234496, 93861.5306923461, 9352.953235233781, 9556.904430955601, 9656.37233579815, 9702.563384647849, 9747.561359738687, 44969.32546011878, 45120.0, 45984.08031839278, 46207.768961156326, 46351.76824115858, 58130.0, 58246.70876645589, 59376.0, 59921.0, 59999.0, 15002.549923502313, 15116.924415378293, 15200.695986080438, 15275.770863436835, 15287.464938727091, 17222.138893055548, 17270.654586907942, 17293.0, 17405.82594174042, 17430.0, 15402.306896189475, 15584.220788960733, 15599.688006240038, 15783.842161578697, 15816.762748559011, 14842.257887105385, 14872.702545949236, 14919.701605968037, 15076.095434273979, 15081.547553572971, 14272.500462483764, 14530.636734081732, 14553.85446145525, 14633.634159146106, 14686.63283417923, 11640.94179529097, 11646.767064658829, 11656.125790565911, 11773.352465614473, 11940.701482463008, 12171.634850954486, 12259.75480490403, 12542.874571254535, 12565.623031309075, 12685.302308373128], "value": 8950.409415649498, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 107.0, 109.0, 110.0, 109.0, 109.0, 107.0, 108.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 119.0, 119.0, 118.0, 118.0, 116.0, 118.0, 119.0, 126.0, 117.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 162.0, 162.0, 165.0, 164.0, 167.0, 165.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 74.0, 75.0, 76.0, 75.0, 75.0, 75.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 78.0, 79.0, 78.0, 79.0, 79.0, 80.0, 80.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 115.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 149.0, 148.0, 150.0, 149.0, 149.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 52.0, 55.0, 54.0, 54.0, 53.0, 54.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 77.0, 72.0, 72.0, 74.0, 75.0, 72.0, 75.0, 75.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 110.0, 111.0, 112.0, 111.0, 109.0, 117.0, 115.0], "value": 111.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 163.0, 173.0, 168.0, 181.0, 169.0, 165.0, 164.0, 174.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 69.0, 70.0, 64.0, 69.0, 66.0, 67.0, 74.0, 66.0], "value": 69.0, "unit": "score"}]}]} 14:42:06 INFO - Return code: 0 14:42:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:42:06 INFO - # TBPL SUCCESS # 14:42:06 INFO - Running post-action listener: _package_coverage_data 14:42:06 INFO - Running post-action listener: _resource_record_post_action 14:42:06 INFO - [mozharness: 2017-09-26 21:42:06.824141Z] Finished run-tests step (success) 14:42:06 INFO - Running post-run listener: _resource_record_post_run 14:42:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 343232512; Read time: 44; Write time: 253028 14:42:06 INFO - TinderboxPrint: CPU usage
13.1% 14:42:06 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 44 14:42:06 INFO - TinderboxPrint: I/O write bytes / time
343,232,512 / 253,028 14:42:06 INFO - TinderboxPrint: CPU idle
8,235.1 (86.9%) 14:42:06 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 14:42:06 INFO - TinderboxPrint: Swap in / out
0 / 0 14:42:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13393920; Read time: 0; Write time: 3244 14:42:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:42:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 329838592; Read time: 32; Write time: 249784 14:42:07 INFO - Running post-run listener: _upload_blobber_files 14:42:07 INFO - Blob upload gear active. 14:42:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:42:07 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'] 14:42:07 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 14:42:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:08 INFO - (blobuploader) - INFO - Done attempting. 14:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:09 INFO - (blobuploader) - INFO - Done attempting. 14:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:13 INFO - (blobuploader) - INFO - Done attempting. 14:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:14 INFO - (blobuploader) - INFO - Done attempting. 14:42:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:14 INFO - Return code: 0 14:42:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7386b48ad9a2c17c4917591cd0de60c6894de883ef16c8a13d54fe2ab40b1fc49920254eaac4009f9eb0215cdb1d0a7ee48b1339acb400307f4d8422311247f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fba1f98f2602642847f0672680c32334c1aea1095d2af41a8c804c6d34723de7bc72dfe716d27aa788e8d2cd810c96b489066a09be317eddd79cf4592eb7b6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e8506c6e6d320280f7697cdd5018818c71ac4053dbffeda560f25127eadf6d8f2548c77abd938eefa2eb8687da1792f6dea547249a82f98af1b0eaa5f44641a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/827d045e0a4144fb7740c5a5996285529ab709e1851894b7248ace49f44af1c868cc63beb8b2e29e4e7adc8267054de0155f050f7bb46c87ee2462a655da9b3c"} 14:42:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:14 INFO - Contents: 14:42:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7386b48ad9a2c17c4917591cd0de60c6894de883ef16c8a13d54fe2ab40b1fc49920254eaac4009f9eb0215cdb1d0a7ee48b1339acb400307f4d8422311247f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fba1f98f2602642847f0672680c32334c1aea1095d2af41a8c804c6d34723de7bc72dfe716d27aa788e8d2cd810c96b489066a09be317eddd79cf4592eb7b6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e8506c6e6d320280f7697cdd5018818c71ac4053dbffeda560f25127eadf6d8f2548c77abd938eefa2eb8687da1792f6dea547249a82f98af1b0eaa5f44641a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/827d045e0a4144fb7740c5a5996285529ab709e1851894b7248ace49f44af1c868cc63beb8b2e29e4e7adc8267054de0155f050f7bb46c87ee2462a655da9b3c"} 14:42:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:14 INFO - Copying logs to upload dir... 14:42:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.135171 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-26 14:42:14.340061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:14.344866) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7386b48ad9a2c17c4917591cd0de60c6894de883ef16c8a13d54fe2ab40b1fc49920254eaac4009f9eb0215cdb1d0a7ee48b1339acb400307f4d8422311247f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fba1f98f2602642847f0672680c32334c1aea1095d2af41a8c804c6d34723de7bc72dfe716d27aa788e8d2cd810c96b489066a09be317eddd79cf4592eb7b6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e8506c6e6d320280f7697cdd5018818c71ac4053dbffeda560f25127eadf6d8f2548c77abd938eefa2eb8687da1792f6dea547249a82f98af1b0eaa5f44641a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/827d045e0a4144fb7740c5a5996285529ab709e1851894b7248ace49f44af1c868cc63beb8b2e29e4e7adc8267054de0155f050f7bb46c87ee2462a655da9b3c"} build_url:https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7386b48ad9a2c17c4917591cd0de60c6894de883ef16c8a13d54fe2ab40b1fc49920254eaac4009f9eb0215cdb1d0a7ee48b1339acb400307f4d8422311247f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57fba1f98f2602642847f0672680c32334c1aea1095d2af41a8c804c6d34723de7bc72dfe716d27aa788e8d2cd810c96b489066a09be317eddd79cf4592eb7b6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e8506c6e6d320280f7697cdd5018818c71ac4053dbffeda560f25127eadf6d8f2548c77abd938eefa2eb8687da1792f6dea547249a82f98af1b0eaa5f44641a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/827d045e0a4144fb7740c5a5996285529ab709e1851894b7248ace49f44af1c868cc63beb8b2e29e4e7adc8267054de0155f050f7bb46c87ee2462a655da9b3c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:14.376122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:14.376505) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506459719.933890-25709714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:14.458400) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 14:42:14.458703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 14:42:14.459034) ========= ========= Total master_lag: 0.06 =========