builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-023 starttime: 1506701305.14 results: success (0) revision: 935eca685536793ab7df8bfc9fb52d70128f7756 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.145137) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.145667) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.145964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.207179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.211043) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 09:08:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.2M=0s 2017-09-29 09:08:25 (26.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091452 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.360630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.360970) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019194 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:25.429882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-09-29 09:08:25.433323) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 935eca685536793ab7df8bfc9fb52d70128f7756 --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 935eca685536793ab7df8bfc9fb52d70128f7756 --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=6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 09:08:25,672 truncating revision to first 12 chars 2017-09-29 09:08:25,673 Setting DEBUG logging. 2017-09-29 09:08:25,673 attempt 1/10 2017-09-29 09:08:25,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/935eca685536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 09:08:26,187 sleeping for 9.00s (attempt 1/10) 2017-09-29 09:08:35,196 attempt 2/10 2017-09-29 09:08:35,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/935eca685536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 09:08:36,115 unpacking tar archive at: mozilla-central-935eca685536/testing/mozharness/ program finished with exit code 0 elapsedTime=10.748062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-09-29 09:08:36.205831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:36.206217) ========= script_repo_revision: 935eca685536793ab7df8bfc9fb52d70128f7756 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:36.206640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:36.206934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 09:08:36.221822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-29 09:08:36.222221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:08:36 INFO - MultiFileLogger online at 20170929 09:08:36 in /builds/slave/test 09:08:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:08:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:36 INFO - {'append_to_log': False, 09:08:36 INFO - 'base_work_dir': '/builds/slave/test', 09:08:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:08:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:36 INFO - 'branch': 'Firefox-Non-PGO', 09:08:36 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:36 INFO - 'code_coverage': False, 09:08:36 INFO - 'config_files': ('talos/linux_config.py',), 09:08:36 INFO - 'default_actions': ('clobber', 09:08:36 INFO - 'read-buildbot-config', 09:08:36 INFO - 'download-and-extract', 09:08:36 INFO - 'populate-webroot', 09:08:36 INFO - 'create-virtualenv', 09:08:36 INFO - 'install', 09:08:36 INFO - 'setup-mitmproxy', 09:08:36 INFO - 'run-tests'), 09:08:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:36 INFO - 'disable_ccov_upload': False, 09:08:36 INFO - 'disable_stylo': False, 09:08:36 INFO - 'download_minidump_stackwalk': True, 09:08:36 INFO - 'download_symbols': 'ondemand', 09:08:36 INFO - 'enable_stylo': False, 09:08:36 INFO - 'enable_webrender': False, 09:08:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:08:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:36 INFO - 'gecko_profile': False, 09:08:36 INFO - 'gecko_profile_interval': 0, 09:08:36 INFO - 'installer_path': 'installer.exe', 09:08:36 INFO - 'log_level': 'info', 09:08:36 INFO - 'log_name': 'talos', 09:08:36 INFO - 'log_to_console': True, 09:08:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:08:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:08:36 INFO - 'opt_config_files': (), 09:08:36 INFO - 'pip_index': False, 09:08:36 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 09:08:36 INFO - 'system_bits': '32', 09:08:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:36 INFO - 'title': 'talos-linux64-ix-023', 09:08:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:36 INFO - 'use_talos_json': True, 09:08:36 INFO - 'verify': 'False', 09:08:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:36 INFO - 'work_dir': 'build'} 09:08:36 INFO - [mozharness: 2017-09-29 16:08:36.600371Z] Running clobber step. 09:08:36 INFO - Running pre-action listener: _resource_record_pre_action 09:08:36 INFO - Running main action method: clobber 09:08:36 INFO - rmtree: /builds/slave/test/build 09:08:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:37 INFO - Running post-action listener: _resource_record_post_action 09:08:37 INFO - [mozharness: 2017-09-29 16:08:37.601957Z] Finished clobber step (success) 09:08:37 INFO - [mozharness: 2017-09-29 16:08:37.602056Z] Running read-buildbot-config step. 09:08:37 INFO - Running pre-action listener: _resource_record_pre_action 09:08:37 INFO - Running main action method: read_buildbot_config 09:08:37 INFO - Using buildbot properties: 09:08:37 INFO - { 09:08:37 INFO - "project": "", 09:08:37 INFO - "product": "firefox", 09:08:37 INFO - "who": "ryanvm@gmail.com", 09:08:37 INFO - "installer_path": "public/build/target.tar.bz2", 09:08:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 09:08:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:08:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 09:08:37 INFO - "stage_platform": "linux64", 09:08:37 INFO - "basedir": "/builds/slave/test", 09:08:37 INFO - "buildnumber": 80, 09:08:37 INFO - "platform": "ubuntu64_hw", 09:08:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:08:37 INFO - "slavebuilddir": "test", 09:08:37 INFO - "taskId": "MZIoyS35SnOoKoUkMvGwcg", 09:08:37 INFO - "branch": "mozilla-central", 09:08:37 INFO - "script_repo_revision": "production", 09:08:37 INFO - "revision": "935eca685536793ab7df8bfc9fb52d70128f7756", 09:08:37 INFO - "slavename": "talos-linux64-ix-023", 09:08:37 INFO - "repo_path": "mozilla-central" 09:08:37 INFO - } 09:08:37 INFO - Finding installer, test and symbols from parent task. 09:08:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MZIoyS35SnOoKoUkMvGwcg'}, attempt #1 09:08:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MZIoyS35SnOoKoUkMvGwcg'}, attempt #1 09:08:38 INFO - Task dependencies: UiJi38FTSiS8xAy402WTnA 09:08:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA'}, attempt #1 09:08:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2 09:08:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.test_packages.json 09:08:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.crashreporter-symbols.zip 09:08:39 INFO - Running post-action listener: _resource_record_post_action 09:08:39 INFO - [mozharness: 2017-09-29 16:08:39.051550Z] Finished read-buildbot-config step (success) 09:08:39 INFO - [mozharness: 2017-09-29 16:08:39.051770Z] Running download-and-extract step. 09:08:39 INFO - Running pre-action listener: _resource_record_pre_action 09:08:39 INFO - Running main action method: download_and_extract 09:08:39 INFO - mkdir: /builds/slave/test/build/tests 09:08:39 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')]} 09:08:39 INFO - trying https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.test_packages.json 09:08:39 INFO - Downloading https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:08:39 INFO - Downloaded 989 bytes. 09:08:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:08:39 INFO - Using the following test package requirements: 09:08:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:08:39 INFO - u'common': [u'target.common.tests.zip'], 09:08:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:08:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:08:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:08:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:08:39 INFO - u'mozbase': [u'target.common.tests.zip'], 09:08:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:08:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:08:39 INFO - u'web-platform': [u'target.common.tests.zip', 09:08:39 INFO - u'target.web-platform.tests.tar.gz'], 09:08:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:08:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:08:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.common.tests.zip 09:08:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:08:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.common.tests.zip into memory 09:08:40 INFO - Content-Length response header: 55366218 09:08:40 INFO - Bytes received: 55366218 09:08:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.talos.tests.zip 09:08:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:08:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.talos.tests.zip into memory 09:08:52 INFO - Content-Length response header: 14521355 09:08:52 INFO - Bytes received: 14521355 09:08:52 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')]} 09:08:52 INFO - trying https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2 09:08:52 INFO - Downloading https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:08:53 INFO - Downloaded 61675301 bytes. 09:08:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2 09:08:53 INFO - mkdir: /builds/slave/test/properties 09:08:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:08:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:08:53 INFO - Contents: 09:08:53 INFO - build_url:https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2 09:08:53 INFO - Running post-action listener: _resource_record_post_action 09:08:53 INFO - Running post-action listener: find_tests_for_verification 09:08:53 INFO - Running post-action listener: set_extra_try_arguments 09:08:53 INFO - [mozharness: 2017-09-29 16:08:53.760080Z] Finished download-and-extract step (success) 09:08:53 INFO - [mozharness: 2017-09-29 16:08:53.760264Z] Running populate-webroot step. 09:08:53 INFO - Running pre-action listener: _resource_record_pre_action 09:08:53 INFO - Running main action method: populate_webroot 09:08:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:08:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['tresize', 09:08:54 INFO - 'tcanvasmark']}, 09:08:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:08:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['dromaeo_css', 09:08:54 INFO - 'kraken']}, 09:08:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'tests': ['damp', 'tps']}, 09:08:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['damp', 'tps']}, 09:08:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:08:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['dromaeo_dom']}, 09:08:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:08:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['basic_compositor_video', 09:08:54 INFO - 'glvideo']}, 09:08:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:08:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['ts_paint_webext', 09:08:54 INFO - 'tp5o_webext']}, 09:08:54 INFO - 'other-e10s': {'tests': ['a11yr', 09:08:54 INFO - 'ts_paint', 09:08:54 INFO - 'tpaint', 09:08:54 INFO - 'sessionrestore', 09:08:54 INFO - 'sessionrestore_many_windows', 09:08:54 INFO - 'sessionrestore_no_auto_restore', 09:08:54 INFO - 'tabpaint', 09:08:54 INFO - 'cpstartup']}, 09:08:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['a11yr', 09:08:54 INFO - 'ts_paint', 09:08:54 INFO - 'tpaint', 09:08:54 INFO - 'sessionrestore', 09:08:54 INFO - 'sessionrestore_many_windows', 09:08:54 INFO - 'sessionrestore_no_auto_restore', 09:08:54 INFO - 'tabpaint', 09:08:54 INFO - 'cpstartup']}, 09:08:54 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 09:08:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:08:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['perf_reftest_singletons']}, 09:08:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['perf_reftest']}, 09:08:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:08:54 INFO - 'tsvgr_opacity', 09:08:54 INFO - 'tart', 09:08:54 INFO - 'tscrollx', 09:08:54 INFO - 'tsvg_static']}, 09:08:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['tsvgx', 09:08:54 INFO - 'tsvgr_opacity', 09:08:54 INFO - 'tart', 09:08:54 INFO - 'tscrollx', 09:08:54 INFO - 'tsvg_static']}, 09:08:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:08:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'talos_options': ['--disable-stylo'], 09:08:54 INFO - 'tests': ['tp5o']}, 09:08:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:08:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 09:08:54 INFO - 'talos_options': ['--mitmproxy', 09:08:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:08:54 INFO - '--firstNonBlankPaint'], 09:08:54 INFO - 'tests': ['tp6_google', 09:08:54 INFO - 'tp6_youtube', 09:08:54 INFO - 'tp6_amazon', 09:08:54 INFO - 'tp6_facebook']}, 09:08:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:08:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 09:08:54 INFO - 'talos_options': ['--disable-stylo', 09:08:54 INFO - '--mitmproxy', 09:08:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:08:54 INFO - '--firstNonBlankPaint'], 09:08:54 INFO - 'tests': ['tp6_google', 09:08:54 INFO - 'tp6_youtube', 09:08:54 INFO - 'tp6_amazon', 09:08:54 INFO - 'tp6_facebook']}, 09:08:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:08:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 09:08:54 INFO - 'talos_options': ['--stylo-threads=1', 09:08:54 INFO - '--mitmproxy', 09:08:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:08:54 INFO - '--firstNonBlankPaint'], 09:08:54 INFO - 'tests': ['tp6_google', 09:08:54 INFO - 'tp6_youtube', 09:08:54 INFO - 'tp6_amazon', 09:08:54 INFO - 'tp6_facebook']}, 09:08:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'talos_options': ['--xperf_path', 09:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:54 INFO - 'tests': ['tp5n']}, 09:08:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:08:54 INFO - 'talos_options': ['--disable-stylo', 09:08:54 INFO - '--xperf_path', 09:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:54 INFO - 'tests': ['tp5n']}}} 09:08:54 INFO - Running post-action listener: _resource_record_post_action 09:08:54 INFO - [mozharness: 2017-09-29 16:08:54.266449Z] Finished populate-webroot step (success) 09:08:54 INFO - [mozharness: 2017-09-29 16:08:54.266674Z] Running create-virtualenv step. 09:08:54 INFO - Running pre-action listener: _resource_record_pre_action 09:08:54 INFO - Running main action method: create_virtualenv 09:08:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:08:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:08:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:08:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:08:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:08:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:08:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:08:55 INFO - Installing pip...............done. 09:08:55 INFO - Return code: 0 09:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:08:55 INFO - Reading from file tmpfile_stdout 09:08:55 INFO - Output received: 09:08:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:55 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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:08:55 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 09:08:55 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 09:08:55 INFO - Using env: {'DISPLAY': ':0', 09:08:55 INFO - 'HOME': '/home/cltbld', 09:08:55 INFO - 'LANG': 'en_US.UTF-8', 09:08:55 INFO - 'LANGUAGE': 'en_US:en', 09:08:55 INFO - 'LOGNAME': 'cltbld', 09:08:55 INFO - 'MAIL': '/var/mail/cltbld', 09:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:55 INFO - 'MOZ_NO_REMOTE': '1', 09:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:55 INFO - 'NO_EM_RESTART': '1', 09:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:55 INFO - 'PWD': '/builds/slave/test', 09:08:55 INFO - 'SHELL': '/bin/bash', 09:08:55 INFO - 'SHLVL': '1', 09:08:55 INFO - 'TERM': 'linux', 09:08:55 INFO - 'TMOUT': '86400', 09:08:55 INFO - 'USER': 'cltbld', 09:08:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:55 INFO - '_': '/tools/buildbot/bin/python'} 09:08:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:08:56 INFO - Downloading/unpacking pip>=1.5 09:08:56 INFO - Running setup.py egg_info for package pip 09:08:56 INFO - warning: no files found matching 'pip/cacert.pem' 09:08:56 INFO - warning: no files found matching '*.html' under directory 'docs' 09:08:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:08:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:08:56 INFO - Installing collected packages: pip 09:08:56 INFO - Found existing installation: pip 1.1 09:08:56 INFO - Uninstalling pip: 09:08:56 INFO - Successfully uninstalled pip 09:08:56 INFO - Running setup.py install for pip 09:08:56 INFO - warning: no files found matching 'pip/cacert.pem' 09:08:56 INFO - warning: no files found matching '*.html' under directory 'docs' 09:08:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:08:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:08:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:08:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:08:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:08:56 INFO - Successfully installed pip 09:08:56 INFO - Cleaning up... 09:08:56 INFO - Return code: 0 09:08:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:08:56 INFO - Using env: {'DISPLAY': ':0', 09:08:56 INFO - 'HOME': '/home/cltbld', 09:08:56 INFO - 'LANG': 'en_US.UTF-8', 09:08:56 INFO - 'LANGUAGE': 'en_US:en', 09:08:56 INFO - 'LOGNAME': 'cltbld', 09:08:56 INFO - 'MAIL': '/var/mail/cltbld', 09:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:56 INFO - 'MOZ_NO_REMOTE': '1', 09:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:56 INFO - 'NO_EM_RESTART': '1', 09:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:56 INFO - 'PWD': '/builds/slave/test', 09:08:56 INFO - 'SHELL': '/bin/bash', 09:08:56 INFO - 'SHLVL': '1', 09:08:56 INFO - 'TERM': 'linux', 09:08:56 INFO - 'TMOUT': '86400', 09:08:56 INFO - 'USER': 'cltbld', 09:08:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:56 INFO - '_': '/tools/buildbot/bin/python'} 09:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:56 INFO - Downloading/unpacking psutil>=3.1.1 09:08:56 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 09:08:56 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 09:08:56 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 09:08:56 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 09:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:57 INFO - Installing collected packages: psutil 09:08:57 INFO - Running setup.py install for psutil 09:08:58 INFO - building 'psutil._psutil_linux' extension 09:08:58 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 09:08:58 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 09:08:58 INFO - building 'psutil._psutil_posix' extension 09:08:58 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 09:08:58 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 09:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:58 INFO - Successfully installed psutil 09:08:58 INFO - Cleaning up... 09:08:58 INFO - Return code: 0 09:08:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:08:58 INFO - Using env: {'DISPLAY': ':0', 09:08:58 INFO - 'HOME': '/home/cltbld', 09:08:58 INFO - 'LANG': 'en_US.UTF-8', 09:08:58 INFO - 'LANGUAGE': 'en_US:en', 09:08:58 INFO - 'LOGNAME': 'cltbld', 09:08:58 INFO - 'MAIL': '/var/mail/cltbld', 09:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:58 INFO - 'MOZ_NO_REMOTE': '1', 09:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:58 INFO - 'NO_EM_RESTART': '1', 09:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:58 INFO - 'PWD': '/builds/slave/test', 09:08:58 INFO - 'SHELL': '/bin/bash', 09:08:58 INFO - 'SHLVL': '1', 09:08:58 INFO - 'TERM': 'linux', 09:08:58 INFO - 'TMOUT': '86400', 09:08:58 INFO - 'USER': 'cltbld', 09:08:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:58 INFO - '_': '/tools/buildbot/bin/python'} 09:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:08:59 INFO - Installing collected packages: mozsystemmonitor 09:08:59 INFO - Running setup.py install for mozsystemmonitor 09:09:00 INFO - Successfully installed mozsystemmonitor 09:09:00 INFO - Cleaning up... 09:09:00 INFO - Return code: 0 09:09:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:09:00 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')]} 09:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:00 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')]} 09:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:00 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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:00 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 09:09:00 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 09:09:00 INFO - Using env: {'DISPLAY': ':0', 09:09:00 INFO - 'HOME': '/home/cltbld', 09:09:00 INFO - 'LANG': 'en_US.UTF-8', 09:09:00 INFO - 'LANGUAGE': 'en_US:en', 09:09:00 INFO - 'LOGNAME': 'cltbld', 09:09:00 INFO - 'MAIL': '/var/mail/cltbld', 09:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:00 INFO - 'MOZ_NO_REMOTE': '1', 09:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:00 INFO - 'NO_EM_RESTART': '1', 09:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:00 INFO - 'PWD': '/builds/slave/test', 09:09:00 INFO - 'SHELL': '/bin/bash', 09:09:00 INFO - 'SHLVL': '1', 09:09:00 INFO - 'TERM': 'linux', 09:09:00 INFO - 'TMOUT': '86400', 09:09:00 INFO - 'USER': 'cltbld', 09:09:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:00 INFO - '_': '/tools/buildbot/bin/python'} 09:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:09:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:09:02 INFO - warning: no files found matching '*.txt' 09:09:02 INFO - no previously-included directories found matching 'build' 09:09:02 INFO - no previously-included directories found matching 'dist' 09:09:02 INFO - no previously-included directories found matching '.git*' 09:09:02 INFO - Installing collected packages: jsonschema, functools32 09:09:02 INFO - Running setup.py install for functools32 09:09:02 INFO - warning: no files found matching '*.txt' 09:09:02 INFO - no previously-included directories found matching 'build' 09:09:02 INFO - no previously-included directories found matching 'dist' 09:09:02 INFO - no previously-included directories found matching '.git*' 09:09:02 INFO - Successfully installed jsonschema functools32 09:09:02 INFO - Cleaning up... 09:09:02 INFO - Return code: 0 09:09:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:09:02 INFO - Using env: {'DISPLAY': ':0', 09:09:02 INFO - 'HOME': '/home/cltbld', 09:09:02 INFO - 'LANG': 'en_US.UTF-8', 09:09:02 INFO - 'LANGUAGE': 'en_US:en', 09:09:02 INFO - 'LOGNAME': 'cltbld', 09:09:02 INFO - 'MAIL': '/var/mail/cltbld', 09:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:02 INFO - 'MOZ_NO_REMOTE': '1', 09:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:02 INFO - 'NO_EM_RESTART': '1', 09:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:02 INFO - 'PWD': '/builds/slave/test', 09:09:02 INFO - 'SHELL': '/bin/bash', 09:09:02 INFO - 'SHLVL': '1', 09:09:02 INFO - 'TERM': 'linux', 09:09:02 INFO - 'TMOUT': '86400', 09:09:02 INFO - 'USER': 'cltbld', 09:09:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:02 INFO - '_': '/tools/buildbot/bin/python'} 09:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:09:02 INFO - Cleaning up... 09:09:02 INFO - Return code: 0 09:09:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:09:02 INFO - Using env: {'DISPLAY': ':0', 09:09:02 INFO - 'HOME': '/home/cltbld', 09:09:02 INFO - 'LANG': 'en_US.UTF-8', 09:09:02 INFO - 'LANGUAGE': 'en_US:en', 09:09:02 INFO - 'LOGNAME': 'cltbld', 09:09:02 INFO - 'MAIL': '/var/mail/cltbld', 09:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:02 INFO - 'MOZ_NO_REMOTE': '1', 09:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:02 INFO - 'NO_EM_RESTART': '1', 09:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:02 INFO - 'PWD': '/builds/slave/test', 09:09:02 INFO - 'SHELL': '/bin/bash', 09:09:02 INFO - 'SHLVL': '1', 09:09:02 INFO - 'TERM': 'linux', 09:09:02 INFO - 'TMOUT': '86400', 09:09:02 INFO - 'USER': 'cltbld', 09:09:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:02 INFO - '_': '/tools/buildbot/bin/python'} 09:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:03 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 09:09:03 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 09:09:03 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 09:09:03 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 09:09:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09:04 INFO - Downloading docopt-0.6.1.tar.gz 09:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:04 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:04 INFO - Running setup.py install for blobuploader 09:09:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:04 INFO - Running setup.py install for requests 09:09:05 INFO - Running setup.py install for docopt 09:09:05 INFO - Successfully installed blobuploader requests docopt 09:09:05 INFO - Cleaning up... 09:09:05 INFO - Return code: 0 09:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:05 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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:05 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 09:09:05 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 09:09:05 INFO - Using env: {'DISPLAY': ':0', 09:09:05 INFO - 'HOME': '/home/cltbld', 09:09:05 INFO - 'LANG': 'en_US.UTF-8', 09:09:05 INFO - 'LANGUAGE': 'en_US:en', 09:09:05 INFO - 'LOGNAME': 'cltbld', 09:09:05 INFO - 'MAIL': '/var/mail/cltbld', 09:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:05 INFO - 'MOZ_NO_REMOTE': '1', 09:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:05 INFO - 'NO_EM_RESTART': '1', 09:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:05 INFO - 'PWD': '/builds/slave/test', 09:09:05 INFO - 'SHELL': '/bin/bash', 09:09:05 INFO - 'SHLVL': '1', 09:09:05 INFO - 'TERM': 'linux', 09:09:05 INFO - 'TMOUT': '86400', 09:09:05 INFO - 'USER': 'cltbld', 09:09:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:05 INFO - '_': '/tools/buildbot/bin/python'} 09:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:05 INFO - Running setup.py (path:/tmp/pip-wg37af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:05 INFO - Running setup.py (path:/tmp/pip-cNJqve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:05 INFO - Running setup.py (path:/tmp/pip-SKwm_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:05 INFO - Running setup.py (path:/tmp/pip-UkBOWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:05 INFO - Running setup.py (path:/tmp/pip-6AVK97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:05 INFO - Running setup.py (path:/tmp/pip-OXXYJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:05 INFO - Running setup.py (path:/tmp/pip-R2N3nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:06 INFO - Running setup.py (path:/tmp/pip-nkkGzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:06 INFO - Running setup.py (path:/tmp/pip-GyO_J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:06 INFO - Running setup.py (path:/tmp/pip-50aFjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:06 INFO - Running setup.py (path:/tmp/pip-IRAhke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:06 INFO - Running setup.py (path:/tmp/pip-_ZkznD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:06 INFO - Running setup.py (path:/tmp/pip-RP4kwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:06 INFO - Running setup.py (path:/tmp/pip-6KVGtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:06 INFO - Running setup.py (path:/tmp/pip-ZM0aYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:06 INFO - Running setup.py (path:/tmp/pip-ndD9Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:06 INFO - Running setup.py (path:/tmp/pip-hWKsoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:06 INFO - Running setup.py install for manifestparser 09:09:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:06 INFO - Running setup.py install for mozcrash 09:09:06 INFO - Running setup.py install for mozdebug 09:09:07 INFO - Running setup.py install for mozdevice 09:09:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Running setup.py install for mozfile 09:09:07 INFO - Running setup.py install for mozhttpd 09:09:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Running setup.py install for mozinfo 09:09:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Running setup.py install for mozInstall 09:09:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Running setup.py install for mozleak 09:09:07 INFO - Running setup.py install for mozlog 09:09:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Running setup.py install for moznetwork 09:09:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:07 INFO - Running setup.py install for mozprocess 09:09:07 INFO - Running setup.py install for mozprofile 09:09:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:08 INFO - Running setup.py install for mozrunner 09:09:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:08 INFO - Running setup.py install for mozscreenshot 09:09:08 INFO - Running setup.py install for moztest 09:09:08 INFO - Running setup.py install for mozversion 09:09:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:08 INFO - Cleaning up... 09:09:08 INFO - Return code: 0 09:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:08 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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:08 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 09:09:08 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 09:09:08 INFO - Using env: {'DISPLAY': ':0', 09:09:08 INFO - 'HOME': '/home/cltbld', 09:09:08 INFO - 'LANG': 'en_US.UTF-8', 09:09:08 INFO - 'LANGUAGE': 'en_US:en', 09:09:08 INFO - 'LOGNAME': 'cltbld', 09:09:08 INFO - 'MAIL': '/var/mail/cltbld', 09:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:08 INFO - 'MOZ_NO_REMOTE': '1', 09:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:08 INFO - 'NO_EM_RESTART': '1', 09:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:08 INFO - 'PWD': '/builds/slave/test', 09:09:08 INFO - 'SHELL': '/bin/bash', 09:09:08 INFO - 'SHLVL': '1', 09:09:08 INFO - 'TERM': 'linux', 09:09:08 INFO - 'TMOUT': '86400', 09:09:08 INFO - 'USER': 'cltbld', 09:09:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:08 INFO - '_': '/tools/buildbot/bin/python'} 09:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:08 INFO - Running setup.py (path:/tmp/pip-xNT0OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:08 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)) 09:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:08 INFO - Running setup.py (path:/tmp/pip-ikccdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:08 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)) 09:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:08 INFO - Running setup.py (path:/tmp/pip-Xdgg9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:08 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)) 09:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:08 INFO - Running setup.py (path:/tmp/pip-nNx0t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:08 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)) 09:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:08 INFO - Running setup.py (path:/tmp/pip-KnVbtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:09 INFO - Running setup.py (path:/tmp/pip-jer17h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:09 INFO - Running setup.py (path:/tmp/pip-fH0Mcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:09 INFO - Running setup.py (path:/tmp/pip-b4JBxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:09 INFO - Running setup.py (path:/tmp/pip-AtOyVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:09 INFO - Running setup.py (path:/tmp/pip-eBv1H5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:09 INFO - Running setup.py (path:/tmp/pip-5DVWK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:09 INFO - Running setup.py (path:/tmp/pip-JrQXr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:09 INFO - Running setup.py (path:/tmp/pip-wB1m7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:09 INFO - Running setup.py (path:/tmp/pip-1wfPIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:09 INFO - Running setup.py (path:/tmp/pip-oQQyUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:09 INFO - Running setup.py (path:/tmp/pip-Ac8nJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:09 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)) 09:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:09 INFO - Running setup.py (path:/tmp/pip-m5EBfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:09 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)) 09:09:09 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)) 09:09:09 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)) 09:09:09 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)) 09:09:09 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)) 09:09:09 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)) 09:09:09 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)) 09:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:09 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 09:09:09 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 09:09:09 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 09:09:09 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 09:09:11 INFO - Downloading blessings-1.6.tar.gz 09:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:11 INFO - Installing collected packages: blessings 09:09:11 INFO - Running setup.py install for blessings 09:09:11 INFO - Successfully installed blessings 09:09:11 INFO - Cleaning up... 09:09:11 INFO - Return code: 0 09:09:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:11 INFO - Reading from file tmpfile_stdout 09:09:11 INFO - Current package versions: 09:09:11 INFO - argparse == 1.2.1 09:09:11 INFO - blessings == 1.6 09:09:11 INFO - blobuploader == 1.2.4 09:09:11 INFO - docopt == 0.6.1 09:09:11 INFO - functools32 == 3.2.3-2 09:09:11 INFO - jsonschema == 2.5.1 09:09:11 INFO - manifestparser == 1.1 09:09:11 INFO - mozInstall == 1.13 09:09:11 INFO - mozcrash == 1.0 09:09:11 INFO - mozdebug == 0.1 09:09:11 INFO - mozdevice == 0.51 09:09:11 INFO - mozfile == 1.2 09:09:11 INFO - mozhttpd == 0.7 09:09:11 INFO - mozinfo == 0.10 09:09:11 INFO - mozleak == 0.1 09:09:11 INFO - mozlog == 3.5 09:09:11 INFO - moznetwork == 0.27 09:09:11 INFO - mozprocess == 0.25 09:09:11 INFO - mozprofile == 0.28 09:09:11 INFO - mozrunner == 6.13 09:09:11 INFO - mozscreenshot == 0.1 09:09:11 INFO - mozsystemmonitor == 0.3 09:09:11 INFO - moztest == 0.8 09:09:11 INFO - mozversion == 1.4 09:09:11 INFO - psutil == 3.1.1 09:09:11 INFO - requests == 1.2.3 09:09:11 INFO - wsgiref == 0.1.2 09:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:11 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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:11 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 09:09:11 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 09:09:11 INFO - Using env: {'DISPLAY': ':0', 09:09:11 INFO - 'HOME': '/home/cltbld', 09:09:11 INFO - 'LANG': 'en_US.UTF-8', 09:09:11 INFO - 'LANGUAGE': 'en_US:en', 09:09:11 INFO - 'LOGNAME': 'cltbld', 09:09:11 INFO - 'MAIL': '/var/mail/cltbld', 09:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:11 INFO - 'MOZ_NO_REMOTE': '1', 09:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:11 INFO - 'NO_EM_RESTART': '1', 09:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:11 INFO - 'PWD': '/builds/slave/test', 09:09:11 INFO - 'SHELL': '/bin/bash', 09:09:11 INFO - 'SHLVL': '1', 09:09:11 INFO - 'TERM': 'linux', 09:09:11 INFO - 'TMOUT': '86400', 09:09:11 INFO - 'USER': 'cltbld', 09:09:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:11 INFO - '_': '/tools/buildbot/bin/python'} 09:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 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)) 09:09:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:09:11 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 09:09:11 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 09:09:11 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 09:09:11 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 09:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:09:12 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)) 09:09:12 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)) 09:09:12 INFO - Installing collected packages: simplejson 09:09:12 INFO - Running setup.py install for simplejson 09:09:12 INFO - building 'simplejson._speedups' extension 09:09:12 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 09:09:13 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 09:09:13 INFO - Successfully installed simplejson 09:09:13 INFO - Cleaning up... 09:09:13 INFO - Return code: 0 09:09:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09:13 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')]} 09:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:13 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')]} 09:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:13 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 0x20ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2275b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, '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': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', '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 09:09:13 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 09:09:13 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 09:09:13 INFO - Using env: {'DISPLAY': ':0', 09:09:13 INFO - 'HOME': '/home/cltbld', 09:09:13 INFO - 'LANG': 'en_US.UTF-8', 09:09:13 INFO - 'LANGUAGE': 'en_US:en', 09:09:13 INFO - 'LOGNAME': 'cltbld', 09:09:13 INFO - 'MAIL': '/var/mail/cltbld', 09:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:13 INFO - 'MOZ_NO_REMOTE': '1', 09:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:13 INFO - 'NO_EM_RESTART': '1', 09:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:13 INFO - 'PWD': '/builds/slave/test', 09:09:13 INFO - 'SHELL': '/bin/bash', 09:09:13 INFO - 'SHLVL': '1', 09:09:13 INFO - 'TERM': 'linux', 09:09:13 INFO - 'TMOUT': '86400', 09:09:13 INFO - 'USER': 'cltbld', 09:09:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:13 INFO - '_': '/tools/buildbot/bin/python'} 09:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:09:14 INFO - Cleaning up... 09:09:14 INFO - Return code: 0 09:09:14 INFO - Running post-action listener: _resource_record_post_action 09:09:14 INFO - Running post-action listener: _start_resource_monitoring 09:09:14 INFO - Starting resource monitoring. 09:09:14 INFO - [mozharness: 2017-09-29 16:09:14.187987Z] Finished create-virtualenv step (success) 09:09:14 INFO - [mozharness: 2017-09-29 16:09:14.188501Z] Running install step. 09:09:14 INFO - Running pre-action listener: _resource_record_pre_action 09:09:14 INFO - Running main action method: install 09:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:14 INFO - Reading from file tmpfile_stdout 09:09:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:14 INFO - Reading from file tmpfile_stdout 09:09:14 INFO - Output received: 09:09:14 INFO - Usage: mozinstall [options] installer 09:09:14 INFO - Options: 09:09:14 INFO - -h, --help show this help message and exit 09:09:14 INFO - -d DEST, --destination=DEST 09:09:14 INFO - Directory to install application into. [default: 09:09:14 INFO - "/builds/slave/test"] 09:09:14 INFO - --app=APP Application being installed. [default: firefox] 09:09:14 INFO - mkdir: /builds/slave/test/build/application 09:09:14 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'] 09:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:09:32 INFO - Reading from file tmpfile_stdout 09:09:32 INFO - Output received: 09:09:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:09:32 INFO - Running post-action listener: _resource_record_post_action 09:09:32 INFO - [mozharness: 2017-09-29 16:09:32.298904Z] Finished install step (success) 09:09:32 INFO - [mozharness: 2017-09-29 16:09:32.299052Z] Running setup-mitmproxy step. 09:09:32 INFO - Running pre-action listener: _resource_record_pre_action 09:09:32 INFO - Running main action method: setup_mitmproxy 09:09:32 INFO - Skipping: mitmproxy is not required 09:09:32 INFO - Running post-action listener: _resource_record_post_action 09:09:32 INFO - [mozharness: 2017-09-29 16:09:32.299594Z] Finished setup-mitmproxy step (success) 09:09:32 INFO - [mozharness: 2017-09-29 16:09:32.299816Z] Running run-tests step. 09:09:32 INFO - Running pre-action listener: _resource_record_pre_action 09:09:32 INFO - Running pre-action listener: _set_gcov_prefix 09:09:32 INFO - Running main action method: run_tests 09:09:32 WARNING - Try message not found. 09:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:09:32 INFO - Python 2.7.3 09:09:32 INFO - Return code: 0 09:09:32 INFO - grabbing minidump binary from tooltool 09:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:32 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 0x2417d60>, '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 0x2418a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2418ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:09:32 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 09:09:32 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 09:09:32 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 09:09:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:09:32 INFO - Return code: 0 09:09:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:09:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:09:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:09:32 INFO - ENV: RUST_BACKTRACE is now full 09:09:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:09:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 09:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 09:09:32 INFO - Using env: {'DISPLAY': ':0', 09:09:32 INFO - 'HOME': '/home/cltbld', 09:09:32 INFO - 'LANG': 'en_US.UTF-8', 09:09:32 INFO - 'LANGUAGE': 'en_US:en', 09:09:32 INFO - 'LOGNAME': 'cltbld', 09:09:32 INFO - 'MAIL': '/var/mail/cltbld', 09:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:32 INFO - 'MOZ_NO_REMOTE': '1', 09:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:32 INFO - 'NO_EM_RESTART': '1', 09:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:32 INFO - 'PWD': '/builds/slave/test', 09:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:09:32 INFO - 'RUST_BACKTRACE': 'full', 09:09:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:09:32 INFO - 'SHELL': '/bin/bash', 09:09:32 INFO - 'SHLVL': '1', 09:09:32 INFO - 'TERM': 'linux', 09:09:32 INFO - 'TMOUT': '86400', 09:09:32 INFO - 'USER': 'cltbld', 09:09:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:32 INFO - '_': '/tools/buildbot/bin/python'} 09:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 09:09:32 INFO - mozversion application_buildid: 20170929151536 09:09:32 INFO - mozversion application_changeset: 935eca685536793ab7df8bfc9fb52d70128f7756 09:09:32 INFO - mozversion application_display_name: Nightly 09:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:09:32 INFO - mozversion application_name: Firefox 09:09:32 INFO - mozversion application_remotingname: firefox 09:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:09:32 INFO - mozversion application_vendor: Mozilla 09:09:32 INFO - mozversion application_version: 58.0a1 09:09:32 INFO - mozversion platform_buildid: 20170929151536 09:09:32 INFO - mozversion platform_changeset: 935eca685536793ab7df8bfc9fb52d70128f7756 09:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:09:32 INFO - mozversion platform_version: 58.0a1 09:09:32 INFO - using testdate: 1506701372 09:09:32 INFO - actual date: 1506701372 09:09:32 INFO - starting webserver on 'localhost:43056' 09:09:32 INFO - SUITE-START | Running 2 tests 09:09:32 INFO - TEST-START | dromaeo_css 09:09:32 INFO - Initialising browser for dromaeo_css test... 09:09:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43056/getInfo.html -profile /tmp/tmp7hNFXW/profile 09:09:32 INFO - TEST-INFO | started process 19759 (/builds/slave/test/build/application/firefox/firefox http://localhost:43056/getInfo.html) 09:09:38 INFO - TEST-INFO | 19759: exit 0 09:09:38 INFO - Browser initialized. 09:09:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:09:38 INFO - Using env: {'DISPLAY': ':0', 09:09:38 INFO - 'HOME': '/home/cltbld', 09:09:38 INFO - 'JSGC_DISABLE_POISONING': '1', 09:09:38 INFO - 'LANG': 'en_US.UTF-8', 09:09:38 INFO - 'LANGUAGE': 'en_US:en', 09:09:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:09:38 INFO - 'LOGNAME': 'cltbld', 09:09:38 INFO - 'MAIL': '/var/mail/cltbld', 09:09:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:09:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:09:38 INFO - 'MOZ_CRASHREPORTER': '1', 09:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:09:38 INFO - 'MOZ_NO_REMOTE': '1', 09:09:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:38 INFO - 'NO_EM_RESTART': '1', 09:09:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:38 INFO - 'PWD': '/builds/slave/test', 09:09:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:09:38 INFO - 'RUST_BACKTRACE': 'full', 09:09:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:09:38 INFO - 'SHELL': '/bin/bash', 09:09:38 INFO - 'SHLVL': '1', 09:09:38 INFO - 'STYLO_FORCE_DISABLED': '1', 09:09:38 INFO - 'TERM': 'linux', 09:09:38 INFO - 'TMOUT': '86400', 09:09:38 INFO - 'USER': 'cltbld', 09:09:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:38 INFO - '_': '/tools/buildbot/bin/python'} 09:09:38 INFO - TEST-INFO | started process 19989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7hNFXW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:38 INFO - PID 19989 | 09:09:38 INFO - PID 19989 | (/builds/slave/test/build/application/firefox/firefox:20037): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:09:38 INFO - PID 19989 | 09:09:49 INFO - PID 19989 | RSS: Main: 153526272 09:09:49 INFO - PID 19989 | 09:12:46 INFO - PID 19989 | Cycle 1(1): loaded http://localhost:43056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43056/tests/dromaeo/cssquery-ext.html) 09:12:48 INFO - PID 19989 | RSS: Main: 150999040 09:12:48 INFO - PID 19989 | 09:15:50 INFO - PID 19989 | Cycle 1(1): loaded http://localhost:43056/tests/dromaeo/cssquery-ext.html (next: http://localhost:43056/tests/dromaeo/cssquery-jquery.html) 09:15:50 INFO - PID 19989 | RSS: Main: 151486464 09:15:50 INFO - PID 19989 | 09:18:52 INFO - PID 19989 | Cycle 1(1): loaded http://localhost:43056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43056/tests/dromaeo/cssquery-mootools.html) 09:18:53 INFO - PID 19989 | RSS: Main: 151265280 09:18:53 INFO - PID 19989 | 09:21:54 INFO - PID 19989 | Cycle 1(1): loaded http://localhost:43056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43056/tests/dromaeo/cssquery-prototype.html) 09:21:55 INFO - PID 19989 | RSS: Main: 152395776 09:21:55 INFO - PID 19989 | 09:24:58 INFO - PID 19989 | Cycle 1(1): loaded http://localhost:43056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43056/tests/dromaeo/cssquery-yui.html) 09:24:59 INFO - PID 19989 | RSS: Main: 155217920 09:24:59 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | Cycle 1(1): loaded http://localhost:43056/tests/dromaeo/cssquery-yui.html (next: http://localhost:43056/tests/dromaeo/cssquery-dojo.html) 09:28:01 INFO - PID 19989 | RSS: Main: 156577792 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | __start_tp_report 09:28:01 INFO - PID 19989 | _x_x_mozilla_page_load 09:28:01 INFO - PID 19989 | _x_x_mozilla_page_load_details 09:28:01 INFO - PID 19989 | |i|pagename|runs| 09:28:01 INFO - PID 19989 | |0;dojo.html;3217.678232176781;3226.403115423647;3257.0880153556996;3259.1363288728485;3262.510623406489;6202.224721909762;6365.204349456318;6419.325970773071;6461.321561236073;6509.251436084852;6183.948728716118;6261.279952805428;6423.100765892767;6564.5404821662505;6565.343465653432;5840.474357307852;5877.177195192677;5919.348871624118;5961.642301461904;5962.850928726773;1202.961032202392;5795.304563452391;5895.469407753301;5908.527317814586;5933.673647949361;5800.448957349066;5801.651900885918;5875.294964604253;5878.764849406019;5891.617044892068;5785.71071446426;5826.737796799154;5905.822825315247;5909.054551271819;5909.674967876765;5788.6816225107605;5788.768449262025;5864.266966629171;5877.735501902424;5890.793822216202;6309.652969086698;6317.557770956035;6344.270408902989;6367.681615919232;6392.6484043377595;6654;6734.393904548614;6762.8309292267595;6766.56017358875;6776.085228494139;6846.828829279258;6849.383555479981;6886.24251332358;6961.303869613049;6962.895556566656;6296.338884417162;6360.268569114564;6377.553571250014;6383.61698298099;6384.042393640944;6950.79147625572;6951.513394062367;7049.4712896532965;7053.89419158713;7057.89413158803;6528.347165283529;6638.402543771083;6663.800085997428;6692.732290708317;6697.062411262427;6689.163854518185;6775.186977562724;6805.523613347117;6809.421199198124;6809.897851532231;6711.362420570038;6792.252852186256;6796.184457865088;6804.047433359334;6815.352541508648;6631.436327912085;6718.395344418928;6729.932700673028;6740.056392105109;6828.624425656637;5308.097623404031;5310.946890531045;5315.282436870973;5324.387695414999;5324.893502129936;4645.279981602857;4684.929726054112;4687;4689.085628302449;4702.717836929795;5721.256236689203;5724.055530837365;5791.768329266866;5808.477237048602;5850.385709500526;6743.629100399427;6846.8972965405555;6859.691313890887;6876.553024053421;6878.58728476293;5725.856853578611;5729.341125770507;5786.363500014995;5787.739551720183;5800.071988481823;5727.198192253088;5763.4812866842185;5825.854353641193;5861.325947516005;5873.471387575139;6677.899831502531;6696.129503164655;6708.798736037927;6710.0941372915;6717.429018533382;6899.517033807585;6987.615681137586;6994.580325180302;6996.895046574204;7016.087908571853;6651.800445986628;6651.966740166268;6658.43403310724;6732.730690772314;6759.763408280884;6547.083408322744;6645.534812563074;6655.767048153291;6665.866682666223;6684.565503242274;6840.657967101724;6862.897056544056;6864.4165245954655;6873.243943166348;6876.931230687629;6539.803805885831;6644.83387915306;6732.730690772511;6770.492213084137;6774.525783195129;6594.670266486753;6594.70323835419;6632.403083722488;6680.63256520896;6694.665266736546;6529.934700652932;6536.607803531803;6618.07346971434;6618.437432818265;6623.635700036544;6537.640429776408;6667.8666426670225;6690.59856408617;6817.2501024888215;6817.454603631797;6355.745770169141;6356.713947872265;6365.681715914093;6367.713452894538;6388.2972872984865 09:28:01 INFO - PID 19989 | |1;ext.html;834.6828205281992;853.6414705823554;854.6196942360652;856.6188046319382;856.6444925355979;39822.20355592886;43096.13807723847;43225;43340.34989475156;43410.565894341045;38679;38717.61282387175;38737.612623873756;38775.61224387755;38833;6960.999999999987;7041.084658994324;7049.154101507826;7051.048108505337;7138.928610713904;7063.85872282554;7153.928460715404;7154.177269614009;7159.105111861018;7178;7129.679164437613;7131.714731410737;7145.321194486515;7150.356467917886;7156.391706704911;7362.926370736278;8015.47899386538;8043.879341809878;8048.195180481935;8050.637721302555;7975.641096150687;8058.51648901062;8060.758177254633;8066.23370779775;8067.193280671944;38906.80546597277;39361.60638393608;39419;40352.59647403518;40513.392299115534;3476.0440878758545;3492.7205823534055;3524.207053412987;3524.8413821377844;3526.4357702767434;32819.50770738441;32883.50674739857;33046.33907321864;33156.33687326264;33335.33329333424;5236.947630523722;5258.55302299305;5262.447443018505;5273.7626806793405;5298.70857102863;194251;196300;196306;196711;197741;43697;44456.77771611186;50286;50618.49381506212;50740.23889641658;53779.73110134502;54854;54922;54929.72535137379;55006.17490737642;16438.671226575403;16564.337426503047;16569.585760356087;16639;16711.91644041772;13611.86388136106;13614.251216183206;13617.114887532278;13631.659208519668;13635.590932272047;14636.755875750681;14637.121772693672;14698.706025879423;14700.852991470163;14831.480898168513;5893.469587737124;5973.641581505037;6032.788852390146;6121.234845644294;6180.351063138306;984.8079624473158;996.2378780233128;996.5714742660581;1010.888802231754;1028.5217373921162;22973.958385360038;23048;23095.422614434436;23197.42006449852;23208.3037508875;1090.7436752363187;1110.7167672243527;1116.9273997190157;1118.5749415222326;1122.5060973171778;12294.938525307316;12320.938395308145;12338.82245213821;12361.117358643285;12391.690207744878;226413;226500;226624;226838;226944;53871.922561549334;53979;54190.458095418544;54538.45461545413;54584;1402.6072699644117;1453.7237924794256;1459.7956286119952;1460.0801495058045;1462.0715845438224;21891.67162492532;22443.66334504951;22516.66225006659;22516.774832252122;22850.885745571166;37615.43576846295;37859.24281514409;37927.24145517129;37970.620293797816;38012.61987380091;195195;195530;195613;195639;196296;35403;36011.27977440489;36471.27057458889;36774.26451471009;36830.26339473142;44912.10175796531;46198;46719.532804672875;46937.29594056024;46971.530284698085;33590.3281934355;33787;34361.140971475914;34411.65588344185;34747.65252347444;33506.329873401904;33921.66078339185;33952.490712639825;33967.66032339645;34576.654233457346;38574.2285154301;38639.22721545497;38659.2268154641;38857.6114238854;39376.2124757509;32907;33013.83493082519;33178.17054573655;33315.500267495525;33514.32971340511;24464.388390290384;24801.87599061993;24889.875550622855;24896.62655060212;25202 09:28:01 INFO - PID 19989 | |2;jquery.html;586.6656006076537;586.7183751799133;605.1739375752097;605.1830029460232;609.3145211636909;22423.103075876945;23204.76795232047;23213.883930580345;23241;23255.186068487605;23090.84545772713;25469;25635.487290254183;25674.486510269784;25703.100391486303;6534.901976470357;6698.56459330142;6725.966370168142;6726.461883049345;6732.562383445085;6601.66991650418;6691.130153080093;6696.59820410777;6792.7962161135;7073;7109.8933515997305;7112.751053713121;7113.217546069954;7113.608751518665;7117.64411779409;7122.679479423413;7129.108861392352;7134.32223938725;7146.464015198881;7150.928490715079;6901.171859376856;6913.965430172867;6951.270116637731;6952.374286314256;6965;28546.857265713745;29461.11616651504;29972.250693732614;30139.246518837204;30217.395652086834;2066.545360020808;2105.610462064523;2107.3783233946024;2108.135664377613;2110.8311335093154;18893;19624.70562941557;20376.592468150702;21453.141874325007;21571.1371545138;2332.47519308156;2350.5651454480976;2396.945344048613;2409.8674572898485;2422.9394265143515;127142.36428817797;132407;147871.2606436961;158565;161633;21238.46903827386;21407.357779266647;21745.56508869814;21837.235696750537;22649.433764156027;43525;43635.56364436315;43740.56259437365;43783.562164378585;43893.561064388945;11388.829167562493;11550.942245288888;11857.822132668018;11932.22440541362;12024.278543287432;9987.101160895554;10035.598576056876;10071.496425178711;10129.442880641636;10135.138513226459;10998.285111467729;11270.887291127148;11424.314541127393;11507.88492115085;11901.226420282654;3786.848526058982;4023.195001696699;4083.305838007546;4106.589341065869;4514.794495907942;920.8480600700943;945.5886689290181;948.1229862377273;953.2659851913987;957.7749228931195;18720.344787932358;19079.42761717123;19309.937953412416;19361.709574356395;19373.903130484257;982.7690492734201;1000.5847573257163;1013.9036791504795;1013.9847902281472;1018.2922868606396;10463.05832475081;10745.301555398873;10768.300060496043;10779.245452818384;10851.620193293196;456105;466080;472066;472900;488774;114393.4280328593;116473.41763291298;116979.41510292565;118105;121915;1041.54172164249;1070.5236169904474;1110.5446766825723;1152.7982603044602;1175.5591653130077;19635.31276405319;19848.206071757544;19981.200751969758;20105.6984145235;20236.392908212776;56163.71918140383;57266.14100788408;57393.42606574048;57447.71276143593;58397.416025840896;74582.62708686422;74770.25229747633;75378;76273.23726762884;76448.61775691085;20159.39521814348;20499.692504612143;20554.28060017952;20573.97130143517;20845.47886302794;23037.424064398525;23086;23100;23157.65263521015;23231.186908458123;18456.35402760897;18522.259109636;18734.71897921505;18821.717674234624;18843.811561884206;16087;16711.331546738482;16831.158442078093;16938.49184524466;17094.487165385057;17743.11284435747;18797.248110075445;18964.336248231797;19009.809901901357;19117.330893418664;20014.099365528295;20134.59730805405;20300.695489567373;20309.695354569987;20325.390238292875;18225.270989160814;18344.816551834312;18700.90649546798;18715.625687485903;18745.812541874406 09:28:01 INFO - PID 19989 | |3;mootools.html;1331.460758392851;1375.800508926205;1386.216787515054;1400.8739213470785;1405.065631355149;14532.346044427999;15159.772603410958;15173.772393414094;15203.77194342083;15206;14873.553793386189;14885.106893586393;14903.10581365119;14958.326875290611;14985.775213371808;2719.29298382421;2866.996551207071;2867.7992540522173;2869.512182928907;2869.540873460247;2713.796465265103;2744.6020327052565;2783.1372274594837;2785.0391614892933;2786.247713117457;2731.740484653955;2752.1055656911585;2753.9449211015767;2757.062598716436;2760.654918135233;2725.7546820786224;2759.2412086676222;2762.1575419496944;2767.8651752781366;2776.7500924916853;2631.578947368431;2667.719889411603;2689.260453375318;2689.9865500672568;2700.2304343262076;14424.567262982022;14765.261736913219;14766.926165369212;14767.113973161644;14770.113793172444;8007.639656215484;8301.916980830236;8304.8339033219;8323.417360784748;8327.458715183493;5378.515933565959;5510.669359838423;5565.41563135873;5667.971660141714;5674.574406919456;2008.8794672319561;2021.7371741673635;2037.6943458481198;2056.4139220322286;2080.063971212945;26664.60003099955;26956.595651065054;27097.72902270972;27116.050938217264;27141.728582714117;6626.86746265072;6851.07510486088;6892.138482689664;7039.049728286718;7070.75252366175;17324.480265592054;17377.47867563975;17383.47849564515;17388.304467821144;17410.65178696419;7858.607069646495;8123.634436450374;8167.264946154874;8167.836643267101;8171.264586187272;7281.907713842966;7464.402847772274;7511.32398084175;7515.8496830063095;7544.3210111089165;5289.735513224324;5423.132298832168;5434.83695489136;5451.209574611659;5467.863303417446;1372.9519466818613;1413.8939579531577;1542.5372388283695;1543.5909483986527;1560.5084398414463;879.0945326313907;898.5552151684827;905.2667339455063;917.2936838634214;930.0188301342014;8299.95850020746;8500.149985001573;8506.191911768496;8537.573121343908;8538.786530336667;724.6413025552386;731.4221764805744;732.2640746050185;739.752183018684;794.3367288314207;5149.7940082397035;5183.611229157828;5280.551153151949;5436.510714035756;5657.038303488417;21472.677909831364;22216.333509994725;22244;22385.664215036788;22623;20555.794442055387;21715.13139474435;21753.347399578037;21863;21879.453013674785;10816.891831081746;10957.50691218897;10960.671179864617;10996.010359067563;11049.613263535737;8204.671813127408;8250.339972802281;8296.211859873303;8448;8650.78373040679;18123.90938045354;18428.907855461173;18672.439826805217;18890.622187556448;19015.52461188481;18967.05164741785;18981.43055708331;19177.52056198606;19243.1340589671;19401.417957461297;10929.781404372026;11035.834462482908;11138.777224455627;11147.554097835995;11175.552977880794;13599.796003059764;13829.377678004314;13834.93082534581;13842.515511957436;13858.792118118035;11326.886731132912;11432.314061156358;11550.191486595857;11602.94198529002;11907.940460297643;10996.340219586851;11097.11223102166;11219.326840389604;11270;11484.081273497934;9955.800883982425;10144.695659130239;10144.79710405773;10153.898461015295;10246.129079028067;7322.890156647548;7335.339819416278;7343.302386273295;7374.594397308199;7425.888611670721;7515.173330933702;7627.351675107678;7657.195994420728;7691.384689224737;7755.3020228177475 09:28:01 INFO - PID 19989 | |4;prototype.html;505.4743067210104;515.1860061103456;533.3413234655201;534.4468475128243;544.4773017902816;6165.53758468115;6248.187735594366;6324.272708638497;6357.586756860806;6370.745170193192;6138.662373569452;6206.7827626033095;6224.906626400608;6236.937630623693;6275.5920865143735;4990.4011518617635;5077.33994580704;5111.539961403473;5138.922916156261;5143.5113664201845;5083.754480152368;5105.693658380509;5135.614828887829;5167.328247327842;5173.249878767577;4988.201887697969;5042.82350117746;5054.646174767768;5077.746112694369;5098.782029817023;5083.491650834924;5100.132977393852;5129.820456284049;5165.431802501722;5168.53483186515;4614.953850461486;4636.884077898079;4654.627629789608;4660.930086048712;4666.230072038144;6165.93441197195;6168.568200225986;6175.4442100210745;6230.937690623081;6268.746250749823;5710.400407957146;5801.941980580183;5825.446582574648;5830.300363956352;5835.970820145914;6594.439472644831;6643.269240383554;6703.262641109474;6744.325567443266;6755.763548275787;4926.334944782444;4931.950680493221;4972.279019542182;4981.825636102719;4995.525425084611;6950.721971121149;6999.965000175018;7012.193597736275;7055.435565154827;7113.288671132846;5118.436971933084;5123.385193776696;5142.6914385137015;5152.686065053387;5177.534021938043;5161.612879034087;5185.662931909489;5202.687838729688;5226.634135610547;5227.921581176285;5505.476979686923;5736.569757268222;5737;5754.7985820496915;5824.864151490503;6266.811995640138;6567.802965911031;6596.901046484307;6625.204975402982;6662.067310576524;1754.2544418622035;1755.6049888774924;1777.7777777777778;1784.4379020608467;1793.5964408008094;1208.1301462946665;1217.1236709569096;1217.7077501399601;1218.9024878009739;1268.67014576209;5620.57845661577;5623.718814059281;5646.6894320811925;5668.659880407189;5683.54531637468;6681.966590167115;6745.8650826983185;6798.422134118557;6803.183617965876;6866.622335771581;5628.549716022709;5675.679727359541;5695.316562012585;5700.6009579329875;5730.885382292331;3487.8256087195537;3506.316268327703;3545.840437180333;3579.838907249128;3587.954865726563;6444.9355506444335;6461.967690161613;6480;6513.967430162914;6548;6918.609881158196;6924;6944.548604340803;6951.582905025714;7074.540154889915;6348.0959210086385;6447.935520644827;6475.370110371107;6475.676216189172;6497.902531462032;6676.165479315086;6735.595864248161;6744.662766861539;6749.966250168718;6801.251862295045;6755.628440435823;6803.93196068033;6807.89788153188;6809.591424514545;6839.179298484214;6376.449420231945;6528.706208220737;6535.3464653534265;6615.4376877965915;6639.900401494078;5044.319016932667;5060.291559181644;5085.46602606721;5132.820351287687;5149.459306772735;6619.569727967667;6661.433778128913;6667.866642667216;6791.3548212919695;6793.218779840382;6460.935390646221;6461.289258181502;6472.773452929125;6498.837529061622;6507.28419873823;6565.898912348002;6577.408033277028;6579.769708060195;6627.845950066151;6672;6372.992507360167;6466.902996454963;6500.902486462802;6528.37980391862;6580.012998050331;6049.912780090862;6404.967975160094;6469.7412103515335;6555.2789193187755;6584.50616203777;6176.857281402955;6214.9067763984485;6273.341299163704;6330.797148541947;6392.9360706392345 09:28:01 INFO - PID 19989 | |5;yui.html;864.6325311742507;907.6051917415929;908.3278374003238;912.5893347993405;923.1691477670096;18299.634007319844;18866.622667546657;19028.334008309714;19410.417687469362;19464.12411441485;22495.66256506154;22688.65967010492;22699.659505107396;22723.091076356966;22734.54530909385;947.2138125355938;958.6692591056075;960.6877764726491;960.9807803843919;964.0118878149882;945.8723072385243;988.9604415823394;1007.3905287301187;1008.8335424654923;1009.328796350426;1064.669952314781;1077.7952189084049;1078.250615822004;1079.1906070447164;1080.5407701726774;1057.86776652918;1066.0192622787054;1066.6106870992032;1066.7013236293851;1067.066316972649;771.8649236383667;774.0131332551042;774.8876412920094;779.555653277632;780.0444455541973;19916.103775330146;20266.898665506724;20788.896055519777;20803.791962080337;21112.894435527724;22110;22385.55228895429;22526;22681.88659056711;22736;17995.280188792432;18251.45245642633;18280;18286.63426731458;18294.451166464893;3273.0508152635944;3369.7135743461836;3748.4189950557434;3793.715471339661;3795.2788970095594;142593;143820;146053;147361.26319368443;149909;16771;16967.830321696623;17012;17249.310027598756;17335.133243337783;30973.535396969062;31015.844920775253;31132.377352452822;31564.36871262562;31692.841535792173;8284.46151000183;8313.6674533018;8353.081161072278;8370.497770133812;8426.620802063922;3649.94525082124;3809.4095415210686;4043.9595604043584;4104.363823607346;4141.503019637663;6137.877242455126;6373.649449280334;6397.584157029778;6406;6417.74329026843;1202.6524115323218;1214.7752665756864;1234.5432190089725;1235.2588446931768;1245.078641805076;682.1711620381261;700.1178515071047;702.3503259484957;709.6558169287891;712.9215786263507;12268;12833.422495987703;13132;13697.89278523154;13770.104943178661;654.715198888485;659.5317324699421;669.2504395077544;669.7923643670478;685.0170006041346;5994.310654274727;6020.909686354708;6040.486558642565;6084.30030546484;6143.293521245025;113443;117442;117557;119242.40378798224;121112;112498.43750781193;116309;117491;117921.4103929492;120024;93111;94280;96616;98249.50875245577;98601.99999999856;11275.7744845101;11423;11608.101695761912;11650.417479125841;11793.11551633648;45049.75956617038;46697.53302466932;46803;47172.528274718185;47278.52721472879;57788.4221157783;58810;59284.70357648184;59802.40197597969;60851;16560.337586496888;16574.834251657812;16982.23579938881;17093.316267349168;17121.97268163914;19373.225070997567;19512.21951121939;19586.60826783485;19598;19910;17520.123993800004;17659.823401765818;17681.734773978656;17710.291588336837;17795.644087118446;17681.292748290438;17692.380766673105;17767.822321776617;17786.911065445107;17979.73030404571;17319.480415587554;17323.393681221096;17398.478045658652;17470.03914784699;17571.385001524886;12161.886520235885;12641.747165056831;12661.366931653565;12866.35668216604;12942.482300707867;13328.600141995756;13421.798673020108;13569.52506662262;13574.457021719021;13615.798636225454 09:28:01 INFO - PID 19989 | __end_tp_report 09:28:01 INFO - PID 19989 | __start_cc_report 09:28:01 INFO - PID 19989 | _x_x_mozilla_cycle_collect,282 09:28:01 INFO - PID 19989 | __end_cc_report 09:28:01 INFO - PID 19989 | __startTimestamp1506702481322__endTimestamp 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | ------- Summary: start ------- 09:28:01 INFO - PID 19989 | Number of tests: 6 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | [#0] dojo.html Cycles:165 Average:6236.66 Median:6539.80 stddev:849.12 (13.0%) stddev-sans-first:818.03 09:28:01 INFO - PID 19989 | Values: 3217.7 3226.4 3257.1 3259.1 3262.5 6202.2 6365.2 6419.3 6461.3 6509.3 6183.9 6261.3 6423.1 6564.5 6565.3 5840.5 5877.2 5919.3 5961.6 5962.9 1203.0 5795.3 5895.5 5908.5 5933.7 5800.4 5801.7 5875.3 5878.8 5891.6 5785.7 5826.7 5905.8 5909.1 5909.7 5788.7 5788.8 5864.3 5877.7 5890.8 6309.7 6317.6 6344.3 6367.7 6392.6 6654.0 6734.4 6762.8 6766.6 6776.1 6846.8 6849.4 6886.2 6961.3 6962.9 6296.3 6360.3 6377.6 6383.6 6384.0 6950.8 6951.5 7049.5 7053.9 7057.9 6528.3 6638.4 6663.8 6692.7 6697.1 6689.2 6775.2 6805.5 6809.4 6809.9 6711.4 6792.3 6796.2 6804.0 6815.4 6631.4 6718.4 6729.9 6740.1 6828.6 5308.1 5310.9 5315.3 5324.4 5324.9 4645.3 4684.9 4687.0 4689.1 4702.7 5721.3 5724.1 5791.8 5808.5 5850.4 6743.6 6846.9 6859.7 6876.6 6878.6 5725.9 5729.3 5786.4 5787.7 5800.1 5727.2 5763.5 5825.9 5861.3 5873.5 6677.9 6696.1 6708.8 6710.1 6717.4 6899.5 6987.6 6994.6 6996.9 7016.1 6651.8 6652.0 6658.4 6732.7 6759.8 6547.1 6645.5 6655.8 6665.9 6684.6 6840.7 6862.9 6864.4 6873.2 6876.9 6539.8 6644.8 6732.7 6770.5 6774.5 6594.7 6594.7 6632.4 6680.6 6694.7 6529.9 6536.6 6618.1 6618.4 6623.6 6537.6 6667.9 6690.6 6817.3 6817.5 6355.7 6356.7 6365.7 6367.7 6388.3 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | [#1] ext.html Cycles:180 Average:38178.12 Median:36802.26 stddev:53537.59 (145.5%) stddev-sans-first:53614.34 09:28:01 INFO - PID 19989 | Values: 834.7 853.6 854.6 856.6 856.6 39822.2 43096.1 43225.0 43340.3 43410.6 38679.0 38717.6 38737.6 38775.6 38833.0 6961.0 7041.1 7049.2 7051.0 7138.9 7063.9 7153.9 7154.2 7159.1 7178.0 7129.7 7131.7 7145.3 7150.4 7156.4 7362.9 8015.5 8043.9 8048.2 8050.6 7975.6 8058.5 8060.8 8066.2 8067.2 38906.8 39361.6 39419.0 40352.6 40513.4 3476.0 3492.7 3524.2 3524.8 3526.4 32819.5 32883.5 33046.3 33156.3 33335.3 5236.9 5258.6 5262.4 5273.8 5298.7 194251.0 196300.0 196306.0 196711.0 197741.0 43697.0 44456.8 50286.0 50618.5 50740.2 53779.7 54854.0 54922.0 54929.7 55006.2 16438.7 16564.3 16569.6 16639.0 16711.9 13611.9 13614.3 13617.1 13631.7 13635.6 14636.8 14637.1 14698.7 14700.9 14831.5 5893.5 5973.6 6032.8 6121.2 6180.4 984.8 996.2 996.6 1010.9 1028.5 22974.0 23048.0 23095.4 23197.4 23208.3 1090.7 1110.7 1116.9 1118.6 1122.5 12294.9 12320.9 12338.8 12361.1 12391.7 226413.0 226500.0 226624.0 226838.0 226944.0 53871.9 53979.0 54190.5 54538.5 54584.0 1402.6 1453.7 1459.8 1460.1 1462.1 21891.7 22443.7 22516.7 22516.8 22850.9 37615.4 37859.2 37927.2 37970.6 38012.6 195195.0 195530.0 195613.0 195639.0 196296.0 35403.0 36011.3 36471.3 36774.3 36830.3 44912.1 46198.0 46719.5 46937.3 46971.5 33590.3 33787.0 34361.1 34411.7 34747.7 33506.3 33921.7 33952.5 33967.7 34576.7 38574.2 38639.2 38659.2 38857.6 39376.2 32907.0 33013.8 33178.2 33315.5 33514.3 24464.4 24801.9 24889.9 24896.6 25202.0 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | [#2] jquery.html Cycles:180 Average:36037.76 Median:21791.40 stddev:79911.70 (366.7%) stddev-sans-first:80091.55 09:28:01 INFO - PID 19989 | Values: 586.7 586.7 605.2 605.2 609.3 22423.1 23204.8 23213.9 23241.0 23255.2 23090.8 25469.0 25635.5 25674.5 25703.1 6534.9 6698.6 6726.0 6726.5 6732.6 6601.7 6691.1 6696.6 6792.8 7073.0 7109.9 7112.8 7113.2 7113.6 7117.6 7122.7 7129.1 7134.3 7146.5 7150.9 6901.2 6914.0 6951.3 6952.4 6965.0 28546.9 29461.1 29972.3 30139.2 30217.4 2066.5 2105.6 2107.4 2108.1 2110.8 18893.0 19624.7 20376.6 21453.1 21571.1 2332.5 2350.6 2396.9 2409.9 2422.9 127142.4 132407.0 147871.3 158565.0 161633.0 21238.5 21407.4 21745.6 21837.2 22649.4 43525.0 43635.6 43740.6 43783.6 43893.6 11388.8 11550.9 11857.8 11932.2 12024.3 9987.1 10035.6 10071.5 10129.4 10135.1 10998.3 11270.9 11424.3 11507.9 11901.2 3786.8 4023.2 4083.3 4106.6 4514.8 920.8 945.6 948.1 953.3 957.8 18720.3 19079.4 19309.9 19361.7 19373.9 982.8 1000.6 1013.9 1014.0 1018.3 10463.1 10745.3 10768.3 10779.2 10851.6 456105.0 466080.0 472066.0 472900.0 488774.0 114393.4 116473.4 116979.4 118105.0 121915.0 1041.5 1070.5 1110.5 1152.8 1175.6 19635.3 19848.2 19981.2 20105.7 20236.4 56163.7 57266.1 57393.4 57447.7 58397.4 74582.6 74770.3 75378.0 76273.2 76448.6 20159.4 20499.7 20554.3 20574.0 20845.5 23037.4 23086.0 23100.0 23157.7 23231.2 18456.4 18522.3 18734.7 18821.7 18843.8 16087.0 16711.3 16831.2 16938.5 17094.5 17743.1 18797.2 18964.3 19009.8 19117.3 20014.1 20134.6 20300.7 20309.7 20325.4 18225.3 18344.8 18700.9 18715.6 18745.8 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | [#3] mootools.html Cycles:180 Average:9403.77 Median:14898.98 stddev:6700.61 (45.0%) stddev-sans-first:6691.96 09:28:01 INFO - PID 19989 | Values: 1331.5 1375.8 1386.2 1400.9 1405.1 14532.3 15159.8 15173.8 15203.8 15206.0 14873.6 14885.1 14903.1 14958.3 14985.8 2719.3 2867.0 2867.8 2869.5 2869.5 2713.8 2744.6 2783.1 2785.0 2786.2 2731.7 2752.1 2753.9 2757.1 2760.7 2725.8 2759.2 2762.2 2767.9 2776.8 2631.6 2667.7 2689.3 2690.0 2700.2 14424.6 14765.3 14766.9 14767.1 14770.1 8007.6 8301.9 8304.8 8323.4 8327.5 5378.5 5510.7 5565.4 5668.0 5674.6 2008.9 2021.7 2037.7 2056.4 2080.1 26664.6 26956.6 27097.7 27116.1 27141.7 6626.9 6851.1 6892.1 7039.0 7070.8 17324.5 17377.5 17383.5 17388.3 17410.7 7858.6 8123.6 8167.3 8167.8 8171.3 7281.9 7464.4 7511.3 7515.8 7544.3 5289.7 5423.1 5434.8 5451.2 5467.9 1373.0 1413.9 1542.5 1543.6 1560.5 879.1 898.6 905.3 917.3 930.0 8300.0 8500.1 8506.2 8537.6 8538.8 724.6 731.4 732.3 739.8 794.3 5149.8 5183.6 5280.6 5436.5 5657.0 21472.7 22216.3 22244.0 22385.7 22623.0 20555.8 21715.1 21753.3 21863.0 21879.5 10816.9 10957.5 10960.7 10996.0 11049.6 8204.7 8250.3 8296.2 8448.0 8650.8 18123.9 18428.9 18672.4 18890.6 19015.5 18967.1 18981.4 19177.5 19243.1 19401.4 10929.8 11035.8 11138.8 11147.6 11175.6 13599.8 13829.4 13834.9 13842.5 13858.8 11326.9 11432.3 11550.2 11602.9 11907.9 10996.3 11097.1 11219.3 11270.0 11484.1 9955.8 10144.7 10144.8 10153.9 10246.1 7322.9 7335.3 7343.3 7374.6 7425.9 7515.2 7627.4 7657.2 7691.4 7755.3 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | [#4] prototype.html Cycles:180 Average:5557.65 Median:6176.15 stddev:1545.18 (25.0%) stddev-sans-first:1502.27 09:28:01 INFO - PID 19989 | Values: 505.5 515.2 533.3 534.4 544.5 6165.5 6248.2 6324.3 6357.6 6370.7 6138.7 6206.8 6224.9 6236.9 6275.6 4990.4 5077.3 5111.5 5138.9 5143.5 5083.8 5105.7 5135.6 5167.3 5173.2 4988.2 5042.8 5054.6 5077.7 5098.8 5083.5 5100.1 5129.8 5165.4 5168.5 4615.0 4636.9 4654.6 4660.9 4666.2 6165.9 6168.6 6175.4 6230.9 6268.7 5710.4 5801.9 5825.4 5830.3 5836.0 6594.4 6643.3 6703.3 6744.3 6755.8 4926.3 4932.0 4972.3 4981.8 4995.5 6950.7 7000.0 7012.2 7055.4 7113.3 5118.4 5123.4 5142.7 5152.7 5177.5 5161.6 5185.7 5202.7 5226.6 5227.9 5505.5 5736.6 5737.0 5754.8 5824.9 6266.8 6567.8 6596.9 6625.2 6662.1 1754.3 1755.6 1777.8 1784.4 1793.6 1208.1 1217.1 1217.7 1218.9 1268.7 5620.6 5623.7 5646.7 5668.7 5683.5 6682.0 6745.9 6798.4 6803.2 6866.6 5628.5 5675.7 5695.3 5700.6 5730.9 3487.8 3506.3 3545.8 3579.8 3588.0 6444.9 6462.0 6480.0 6514.0 6548.0 6918.6 6924.0 6944.5 6951.6 7074.5 6348.1 6447.9 6475.4 6475.7 6497.9 6676.2 6735.6 6744.7 6750.0 6801.3 6755.6 6803.9 6807.9 6809.6 6839.2 6376.4 6528.7 6535.3 6615.4 6639.9 5044.3 5060.3 5085.5 5132.8 5149.5 6619.6 6661.4 6667.9 6791.4 6793.2 6460.9 6461.3 6472.8 6498.8 6507.3 6565.9 6577.4 6579.8 6627.8 6672.0 6373.0 6466.9 6500.9 6528.4 6580.0 6049.9 6405.0 6469.7 6555.3 6584.5 6176.9 6214.9 6273.3 6330.8 6392.9 09:28:01 INFO - PID 19989 | 09:28:01 INFO - PID 19989 | [#5] yui.html Cycles:180 Average:25299.81 Median:19592.30 stddev:36071.61 (184.1%) stddev-sans-first:36126.14 09:28:01 INFO - PID 19989 | Values: 864.6 907.6 908.3 912.6 923.2 18299.6 18866.6 19028.3 19410.4 19464.1 22495.7 22688.7 22699.7 22723.1 22734.5 947.2 958.7 960.7 961.0 964.0 945.9 989.0 1007.4 1008.8 1009.3 1064.7 1077.8 1078.3 1079.2 1080.5 1057.9 1066.0 1066.6 1066.7 1067.1 771.9 774.0 774.9 779.6 780.0 19916.1 20266.9 20788.9 20803.8 21112.9 22110.0 22385.6 22526.0 22681.9 22736.0 17995.3 18251.5 18280.0 18286.6 18294.5 3273.1 3369.7 3748.4 3793.7 3795.3 142593.0 143820.0 146053.0 147361.3 149909.0 16771.0 16967.8 17012.0 17249.3 17335.1 30973.5 31015.8 31132.4 31564.4 31692.8 8284.5 8313.7 8353.1 8370.5 8426.6 3649.9 3809.4 4044.0 4104.4 4141.5 6137.9 6373.6 6397.6 6406.0 6417.7 1202.7 1214.8 1234.5 1235.3 1245.1 682.2 700.1 702.4 709.7 712.9 12268.0 12833.4 13132.0 13697.9 13770.1 654.7 659.5 669.3 669.8 685.0 5994.3 6020.9 6040.5 6084.3 6143.3 113443.0 117442.0 117557.0 119242.4 121112.0 112498.4 116309.0 117491.0 117921.4 120024.0 93111.0 94280.0 96616.0 98249.5 98602.0 11275.8 11423.0 11608.1 11650.4 11793.1 45049.8 46697.5 46803.0 47172.5 47278.5 57788.4 58810.0 59284.7 59802.4 60851.0 16560.3 16574.8 16982.2 17093.3 17122.0 19373.2 19512.2 19586.6 19598.0 19910.0 17520.1 17659.8 17681.7 17710.3 17795.6 17681.3 17692.4 17767.8 17786.9 17979.7 17319.5 17323.4 17398.5 17470.0 17571.4 12161.9 12641.7 12661.4 12866.4 12942.5 13328.6 13421.8 13569.5 13574.5 13615.8 09:28:01 INFO - PID 19989 | -------- Summary: end -------- 09:28:01 INFO - PID 19989 | 09:28:01 INFO - TEST-INFO | 19989: exit 0 09:28:01 INFO - TEST-OK | dromaeo_css | took 1109126ms 09:28:01 INFO - TEST-START | kraken 09:28:01 INFO - Initialising browser for kraken test... 09:28:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43056/getInfo.html -profile /tmp/tmp0wid87/profile 09:28:01 INFO - TEST-INFO | started process 20349 (/builds/slave/test/build/application/firefox/firefox http://localhost:43056/getInfo.html) 09:28:06 INFO - TEST-INFO | 20349: exit 0 09:28:06 INFO - Browser initialized. 09:28:06 INFO - Running cycle 1/1 for kraken test... 09:28:06 INFO - Using env: {'DISPLAY': ':0', 09:28:06 INFO - 'HOME': '/home/cltbld', 09:28:06 INFO - 'JSGC_DISABLE_POISONING': '1', 09:28:06 INFO - 'LANG': 'en_US.UTF-8', 09:28:06 INFO - 'LANGUAGE': 'en_US:en', 09:28:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:28:06 INFO - 'LOGNAME': 'cltbld', 09:28:06 INFO - 'MAIL': '/var/mail/cltbld', 09:28:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:28:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:28:06 INFO - 'MOZ_CRASHREPORTER': '1', 09:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:28:06 INFO - 'MOZ_NO_REMOTE': '1', 09:28:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:06 INFO - 'NO_EM_RESTART': '1', 09:28:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:06 INFO - 'PWD': '/builds/slave/test', 09:28:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:28:06 INFO - 'RUST_BACKTRACE': 'full', 09:28:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:28:06 INFO - 'SHELL': '/bin/bash', 09:28:06 INFO - 'SHLVL': '1', 09:28:06 INFO - 'STYLO_FORCE_DISABLED': '1', 09:28:06 INFO - 'TERM': 'linux', 09:28:06 INFO - 'TMOUT': '86400', 09:28:06 INFO - 'USER': 'cltbld', 09:28:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102', 09:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:06 INFO - '_': '/tools/buildbot/bin/python'} 09:28:06 INFO - TEST-INFO | started process 20580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0wid87/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:07 INFO - PID 20580 | 09:28:07 INFO - PID 20580 | (/builds/slave/test/build/application/firefox/firefox:20629): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:28:07 INFO - PID 20580 | 09:28:18 INFO - PID 20580 | RSS: Main: 153407488 09:28:18 INFO - PID 20580 | 09:28:20 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43056/tests/kraken/driver.html?testName=audio-beat-detection) 09:28:21 INFO - PID 20580 | RSS: Main: 160067584 09:28:21 INFO - PID 20580 | 09:28:24 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43056/tests/kraken/driver.html?testName=audio-dft) 09:28:24 INFO - PID 20580 | RSS: Main: 160329728 09:28:24 INFO - PID 20580 | 09:28:27 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43056/tests/kraken/driver.html?testName=audio-fft) 09:28:28 INFO - PID 20580 | RSS: Main: 156291072 09:28:28 INFO - PID 20580 | 09:28:30 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43056/tests/kraken/driver.html?testName=audio-oscillator) 09:28:31 INFO - PID 20580 | RSS: Main: 156774400 09:28:31 INFO - PID 20580 | 09:28:33 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:28:33 INFO - PID 20580 | RSS: Main: 156598272 09:28:33 INFO - PID 20580 | 09:28:37 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43056/tests/kraken/driver.html?testName=imaging-darkroom) 09:28:37 INFO - PID 20580 | RSS: Main: 158990336 09:28:37 INFO - PID 20580 | 09:28:41 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43056/tests/kraken/driver.html?testName=imaging-desaturate) 09:28:41 INFO - PID 20580 | RSS: Main: 159690752 09:28:41 INFO - PID 20580 | 09:28:44 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43056/tests/kraken/driver.html?testName=json-parse-financial) 09:28:45 INFO - PID 20580 | RSS: Main: 159555584 09:28:45 INFO - PID 20580 | 09:28:47 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:28:47 INFO - PID 20580 | RSS: Main: 159252480 09:28:47 INFO - PID 20580 | 09:28:49 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:28:50 INFO - PID 20580 | RSS: Main: 159428608 09:28:50 INFO - PID 20580 | 09:28:52 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:52 INFO - PID 20580 | RSS: Main: 156565504 09:28:52 INFO - PID 20580 | 09:28:55 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:56 INFO - PID 20580 | RSS: Main: 156680192 09:28:56 INFO - PID 20580 | 09:28:58 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:59 INFO - PID 20580 | RSS: Main: 156811264 09:28:59 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | Cycle 1(1): loaded http://localhost:43056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43056/tests/kraken/driver.html?testName=ai-astar) 09:29:01 INFO - PID 20580 | RSS: Main: 158302208 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | __start_tp_report 09:29:01 INFO - PID 20580 | _x_x_mozilla_page_load 09:29:01 INFO - PID 20580 | _x_x_mozilla_page_load_details 09:29:01 INFO - PID 20580 | |i|pagename|runs| 09:29:01 INFO - PID 20580 | |0;ai-astar;106;107;110;108;107;111;108;108;106;108 09:29:01 INFO - PID 20580 | |1;audio-beat-detection;115;116;115;121;118;149;122;116;120;116 09:29:01 INFO - PID 20580 | |2;audio-dft;164;162;165;165;164;163;168;168;173;166 09:29:01 INFO - PID 20580 | |3;audio-fft;74;74;73;76;77;75;73;74;76;74 09:29:01 INFO - PID 20580 | |4;audio-oscillator;80;80;79;78;80;79;79;78;80;144 09:29:01 INFO - PID 20580 | |5;imaging-gaussian-blur;112;112;111;113;112;112;112;112;118;111 09:29:01 INFO - PID 20580 | |6;imaging-darkroom;163;152;149;147;150;149;150;148;149;148 09:29:01 INFO - PID 20580 | |7;imaging-desaturate;95;95;94;94;95;94;96;94;95;96 09:29:01 INFO - PID 20580 | |8;json-parse-financial;54;53;52;53;54;52;53;53;54;54 09:29:01 INFO - PID 20580 | |9;json-stringify-tinderbox;37;37;37;38;46;37;37;37;37;40 09:29:01 INFO - PID 20580 | |10;stanford-crypto-aes;74;74;76;78;79;74;75;84;74;75 09:29:01 INFO - PID 20580 | |11;stanford-crypto-ccm;115;114;118;112;114;114;112;115;118;111 09:29:01 INFO - PID 20580 | |12;stanford-crypto-pbkdf2;160;174;165;165;168;176;162;162;160;161 09:29:01 INFO - PID 20580 | |13;stanford-crypto-sha256-iterative;68;71;62;67;63;66;64;63;63;63 09:29:01 INFO - PID 20580 | __end_tp_report 09:29:01 INFO - PID 20580 | __start_cc_report 09:29:01 INFO - PID 20580 | _x_x_mozilla_cycle_collect,698 09:29:01 INFO - PID 20580 | __end_cc_report 09:29:01 INFO - PID 20580 | __startTimestamp1506702541562__endTimestamp 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | ------- Summary: start ------- 09:29:01 INFO - PID 20580 | Number of tests: 14 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:1.60 (1.5%) stddev-sans-first:1.54 09:29:01 INFO - PID 20580 | Values: 106.0 107.0 110.0 108.0 107.0 111.0 108.0 108.0 106.0 108.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:119.00 stddev:10.23 (8.6%) stddev-sans-first:10.63 09:29:01 INFO - PID 20580 | Values: 115.0 116.0 115.0 121.0 118.0 149.0 122.0 116.0 120.0 116.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.19 (1.9%) stddev-sans-first:3.32 09:29:01 INFO - PID 20580 | Values: 164.0 162.0 165.0 165.0 164.0 163.0 168.0 168.0 173.0 166.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#3] audio-fft Cycles:10 Average:74.60 Median:74.50 stddev:1.35 (1.8%) stddev-sans-first:1.41 09:29:01 INFO - PID 20580 | Values: 74.0 74.0 73.0 76.0 77.0 75.0 73.0 74.0 76.0 74.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:79.50 stddev:20.50 (25.8%) stddev-sans-first:21.64 09:29:01 INFO - PID 20580 | Values: 80.0 80.0 79.0 78.0 80.0 79.0 79.0 78.0 80.0 144.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:112.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 09:29:01 INFO - PID 20580 | Values: 112.0 112.0 111.0 113.0 112.0 112.0 112.0 112.0 118.0 111.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:149.50 stddev:4.60 (3.1%) stddev-sans-first:1.45 09:29:01 INFO - PID 20580 | Values: 163.0 152.0 149.0 147.0 150.0 149.0 150.0 148.0 149.0 148.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:29:01 INFO - PID 20580 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 96.0 94.0 95.0 96.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:0.79 (1.5%) stddev-sans-first:0.78 09:29:01 INFO - PID 20580 | Values: 54.0 53.0 52.0 53.0 54.0 52.0 53.0 53.0 54.0 54.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:37.00 stddev:2.87 (7.8%) stddev-sans-first:3.00 09:29:01 INFO - PID 20580 | Values: 37.0 37.0 37.0 38.0 46.0 37.0 37.0 37.0 37.0 40.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:3.23 (4.3%) stddev-sans-first:3.32 09:29:01 INFO - PID 20580 | Values: 74.0 74.0 76.0 78.0 79.0 74.0 75.0 84.0 74.0 75.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.50 stddev:2.36 (2.1%) stddev-sans-first:2.49 09:29:01 INFO - PID 20580 | Values: 115.0 114.0 118.0 112.0 114.0 114.0 112.0 115.0 118.0 111.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.00 stddev:5.72 (3.5%) stddev-sans-first:5.73 09:29:01 INFO - PID 20580 | Values: 160.0 174.0 165.0 165.0 168.0 176.0 162.0 162.0 160.0 161.0 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.91 (4.5%) stddev-sans-first:2.87 09:29:01 INFO - PID 20580 | Values: 68.0 71.0 62.0 67.0 63.0 66.0 64.0 63.0 63.0 63.0 09:29:01 INFO - PID 20580 | -------- Summary: end -------- 09:29:01 INFO - PID 20580 | 09:29:01 INFO - PID 20580 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:29:02 INFO - TEST-INFO | 20580: exit 0 09:29:02 INFO - TEST-OK | kraken | took 60418ms 09:29:02 INFO - SUITE-END | took 1169s 09:29:02 INFO - Completed test suite (00:19:29) 09:29:02 INFO - javascript benchmark 09:29:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8754.87763843341, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3217.678232176781, 3226.403115423647, 3257.0880153556996, 3259.1363288728485, 3262.510623406489, 6202.224721909762, 6365.204349456318, 6419.325970773071, 6461.321561236073, 6509.251436084852, 6183.948728716118, 6261.279952805428, 6423.100765892767, 6564.5404821662505, 6565.343465653432, 5840.474357307852, 5877.177195192677, 5919.348871624118, 5961.642301461904, 5962.850928726773, 1202.961032202392, 5795.304563452391, 5895.469407753301, 5908.527317814586, 5933.673647949361, 5800.448957349066, 5801.651900885918, 5875.294964604253, 5878.764849406019, 5891.617044892068, 5785.71071446426, 5826.737796799154, 5905.822825315247, 5909.054551271819, 5909.674967876765, 5788.6816225107605, 5788.768449262025, 5864.266966629171, 5877.735501902424, 5890.793822216202, 6309.652969086698, 6317.557770956035, 6344.270408902989, 6367.681615919232, 6392.6484043377595, 6654.0, 6734.393904548614, 6762.8309292267595, 6766.56017358875, 6776.085228494139, 6846.828829279258, 6849.383555479981, 6886.24251332358, 6961.303869613049, 6962.895556566656, 6296.338884417162, 6360.268569114564, 6377.553571250014, 6383.61698298099, 6384.042393640944, 6950.79147625572, 6951.513394062367, 7049.4712896532965, 7053.89419158713, 7057.89413158803, 6528.347165283529, 6638.402543771083, 6663.800085997428, 6692.732290708317, 6697.062411262427, 6689.163854518185, 6775.186977562724, 6805.523613347117, 6809.421199198124, 6809.897851532231, 6711.362420570038, 6792.252852186256, 6796.184457865088, 6804.047433359334, 6815.352541508648, 6631.436327912085, 6718.395344418928, 6729.932700673028, 6740.056392105109, 6828.624425656637, 5308.097623404031, 5310.946890531045, 5315.282436870973, 5324.387695414999, 5324.893502129936, 4645.279981602857, 4684.929726054112, 4687.0, 4689.085628302449, 4702.717836929795, 5721.256236689203, 5724.055530837365, 5791.768329266866, 5808.477237048602, 5850.385709500526, 6743.629100399427, 6846.8972965405555, 6859.691313890887, 6876.553024053421, 6878.58728476293, 5725.856853578611, 5729.341125770507, 5786.363500014995, 5787.739551720183, 5800.071988481823, 5727.198192253088, 5763.4812866842185, 5825.854353641193, 5861.325947516005, 5873.471387575139, 6677.899831502531, 6696.129503164655, 6708.798736037927, 6710.0941372915, 6717.429018533382, 6899.517033807585, 6987.615681137586, 6994.580325180302, 6996.895046574204, 7016.087908571853, 6651.800445986628, 6651.966740166268, 6658.43403310724, 6732.730690772314, 6759.763408280884, 6547.083408322744, 6645.534812563074, 6655.767048153291, 6665.866682666223, 6684.565503242274, 6840.657967101724, 6862.897056544056, 6864.4165245954655, 6873.243943166348, 6876.931230687629, 6539.803805885831, 6644.83387915306, 6732.730690772511, 6770.492213084137, 6774.525783195129, 6594.670266486753, 6594.70323835419, 6632.403083722488, 6680.63256520896, 6694.665266736546, 6529.934700652932, 6536.607803531803, 6618.07346971434, 6618.437432818265, 6623.635700036544, 6537.640429776408, 6667.8666426670225, 6690.59856408617, 6817.2501024888215, 6817.454603631797, 6355.745770169141, 6356.713947872265, 6365.681715914093, 6367.713452894538, 6388.2972872984865], "value": 6175.675136299812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.6828205281992, 853.6414705823554, 854.6196942360652, 856.6188046319382, 856.6444925355979, 39822.20355592886, 43096.13807723847, 43225.0, 43340.34989475156, 43410.565894341045, 38679.0, 38717.61282387175, 38737.612623873756, 38775.61224387755, 38833.0, 6960.999999999987, 7041.084658994324, 7049.154101507826, 7051.048108505337, 7138.928610713904, 7063.85872282554, 7153.928460715404, 7154.177269614009, 7159.105111861018, 7178.0, 7129.679164437613, 7131.714731410737, 7145.321194486515, 7150.356467917886, 7156.391706704911, 7362.926370736278, 8015.47899386538, 8043.879341809878, 8048.195180481935, 8050.637721302555, 7975.641096150687, 8058.51648901062, 8060.758177254633, 8066.23370779775, 8067.193280671944, 38906.80546597277, 39361.60638393608, 39419.0, 40352.59647403518, 40513.392299115534, 3476.0440878758545, 3492.7205823534055, 3524.207053412987, 3524.8413821377844, 3526.4357702767434, 32819.50770738441, 32883.50674739857, 33046.33907321864, 33156.33687326264, 33335.33329333424, 5236.947630523722, 5258.55302299305, 5262.447443018505, 5273.7626806793405, 5298.70857102863, 194251.0, 196300.0, 196306.0, 196711.0, 197741.0, 43697.0, 44456.77771611186, 50286.0, 50618.49381506212, 50740.23889641658, 53779.73110134502, 54854.0, 54922.0, 54929.72535137379, 55006.17490737642, 16438.671226575403, 16564.337426503047, 16569.585760356087, 16639.0, 16711.91644041772, 13611.86388136106, 13614.251216183206, 13617.114887532278, 13631.659208519668, 13635.590932272047, 14636.755875750681, 14637.121772693672, 14698.706025879423, 14700.852991470163, 14831.480898168513, 5893.469587737124, 5973.641581505037, 6032.788852390146, 6121.234845644294, 6180.351063138306, 984.8079624473158, 996.2378780233128, 996.5714742660581, 1010.888802231754, 1028.5217373921162, 22973.958385360038, 23048.0, 23095.422614434436, 23197.42006449852, 23208.3037508875, 1090.7436752363187, 1110.7167672243527, 1116.9273997190157, 1118.5749415222326, 1122.5060973171778, 12294.938525307316, 12320.938395308145, 12338.82245213821, 12361.117358643285, 12391.690207744878, 226413.0, 226500.0, 226624.0, 226838.0, 226944.0, 53871.922561549334, 53979.0, 54190.458095418544, 54538.45461545413, 54584.0, 1402.6072699644117, 1453.7237924794256, 1459.7956286119952, 1460.0801495058045, 1462.0715845438224, 21891.67162492532, 22443.66334504951, 22516.66225006659, 22516.774832252122, 22850.885745571166, 37615.43576846295, 37859.24281514409, 37927.24145517129, 37970.620293797816, 38012.61987380091, 195195.0, 195530.0, 195613.0, 195639.0, 196296.0, 35403.0, 36011.27977440489, 36471.27057458889, 36774.26451471009, 36830.26339473142, 44912.10175796531, 46198.0, 46719.532804672875, 46937.29594056024, 46971.530284698085, 33590.3281934355, 33787.0, 34361.140971475914, 34411.65588344185, 34747.65252347444, 33506.329873401904, 33921.66078339185, 33952.490712639825, 33967.66032339645, 34576.654233457346, 38574.2285154301, 38639.22721545497, 38659.2268154641, 38857.6114238854, 39376.2124757509, 32907.0, 33013.83493082519, 33178.17054573655, 33315.500267495525, 33514.32971340511, 24464.388390290384, 24801.87599061993, 24889.875550622855, 24896.62655060212, 25202.0], "value": 17419.493402399927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6656006076537, 586.7183751799133, 605.1739375752097, 605.1830029460232, 609.3145211636909, 22423.103075876945, 23204.76795232047, 23213.883930580345, 23241.0, 23255.186068487605, 23090.84545772713, 25469.0, 25635.487290254183, 25674.486510269784, 25703.100391486303, 6534.901976470357, 6698.56459330142, 6725.966370168142, 6726.461883049345, 6732.562383445085, 6601.66991650418, 6691.130153080093, 6696.59820410777, 6792.7962161135, 7073.0, 7109.8933515997305, 7112.751053713121, 7113.217546069954, 7113.608751518665, 7117.64411779409, 7122.679479423413, 7129.108861392352, 7134.32223938725, 7146.464015198881, 7150.928490715079, 6901.171859376856, 6913.965430172867, 6951.270116637731, 6952.374286314256, 6965.0, 28546.857265713745, 29461.11616651504, 29972.250693732614, 30139.246518837204, 30217.395652086834, 2066.545360020808, 2105.610462064523, 2107.3783233946024, 2108.135664377613, 2110.8311335093154, 18893.0, 19624.70562941557, 20376.592468150702, 21453.141874325007, 21571.1371545138, 2332.47519308156, 2350.5651454480976, 2396.945344048613, 2409.8674572898485, 2422.9394265143515, 127142.36428817797, 132407.0, 147871.2606436961, 158565.0, 161633.0, 21238.46903827386, 21407.357779266647, 21745.56508869814, 21837.235696750537, 22649.433764156027, 43525.0, 43635.56364436315, 43740.56259437365, 43783.562164378585, 43893.561064388945, 11388.829167562493, 11550.942245288888, 11857.822132668018, 11932.22440541362, 12024.278543287432, 9987.101160895554, 10035.598576056876, 10071.496425178711, 10129.442880641636, 10135.138513226459, 10998.285111467729, 11270.887291127148, 11424.314541127393, 11507.88492115085, 11901.226420282654, 3786.848526058982, 4023.195001696699, 4083.305838007546, 4106.589341065869, 4514.794495907942, 920.8480600700943, 945.5886689290181, 948.1229862377273, 953.2659851913987, 957.7749228931195, 18720.344787932358, 19079.42761717123, 19309.937953412416, 19361.709574356395, 19373.903130484257, 982.7690492734201, 1000.5847573257163, 1013.9036791504795, 1013.9847902281472, 1018.2922868606396, 10463.05832475081, 10745.301555398873, 10768.300060496043, 10779.245452818384, 10851.620193293196, 456105.0, 466080.0, 472066.0, 472900.0, 488774.0, 114393.4280328593, 116473.41763291298, 116979.41510292565, 118105.0, 121915.0, 1041.54172164249, 1070.5236169904474, 1110.5446766825723, 1152.7982603044602, 1175.5591653130077, 19635.31276405319, 19848.206071757544, 19981.200751969758, 20105.6984145235, 20236.392908212776, 56163.71918140383, 57266.14100788408, 57393.42606574048, 57447.71276143593, 58397.416025840896, 74582.62708686422, 74770.25229747633, 75378.0, 76273.23726762884, 76448.61775691085, 20159.39521814348, 20499.692504612143, 20554.28060017952, 20573.97130143517, 20845.47886302794, 23037.424064398525, 23086.0, 23100.0, 23157.65263521015, 23231.186908458123, 18456.35402760897, 18522.259109636, 18734.71897921505, 18821.717674234624, 18843.811561884206, 16087.0, 16711.331546738482, 16831.158442078093, 16938.49184524466, 17094.487165385057, 17743.11284435747, 18797.248110075445, 18964.336248231797, 19009.809901901357, 19117.330893418664, 20014.099365528295, 20134.59730805405, 20300.695489567373, 20309.695354569987, 20325.390238292875, 18225.270989160814, 18344.816551834312, 18700.90649546798, 18715.625687485903, 18745.812541874406], "value": 13035.62543608246, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.460758392851, 1375.800508926205, 1386.216787515054, 1400.8739213470785, 1405.065631355149, 14532.346044427999, 15159.772603410958, 15173.772393414094, 15203.77194342083, 15206.0, 14873.553793386189, 14885.106893586393, 14903.10581365119, 14958.326875290611, 14985.775213371808, 2719.29298382421, 2866.996551207071, 2867.7992540522173, 2869.512182928907, 2869.540873460247, 2713.796465265103, 2744.6020327052565, 2783.1372274594837, 2785.0391614892933, 2786.247713117457, 2731.740484653955, 2752.1055656911585, 2753.9449211015767, 2757.062598716436, 2760.654918135233, 2725.7546820786224, 2759.2412086676222, 2762.1575419496944, 2767.8651752781366, 2776.7500924916853, 2631.578947368431, 2667.719889411603, 2689.260453375318, 2689.9865500672568, 2700.2304343262076, 14424.567262982022, 14765.261736913219, 14766.926165369212, 14767.113973161644, 14770.113793172444, 8007.639656215484, 8301.916980830236, 8304.8339033219, 8323.417360784748, 8327.458715183493, 5378.515933565959, 5510.669359838423, 5565.41563135873, 5667.971660141714, 5674.574406919456, 2008.8794672319561, 2021.7371741673635, 2037.6943458481198, 2056.4139220322286, 2080.063971212945, 26664.60003099955, 26956.595651065054, 27097.72902270972, 27116.050938217264, 27141.728582714117, 6626.86746265072, 6851.07510486088, 6892.138482689664, 7039.049728286718, 7070.75252366175, 17324.480265592054, 17377.47867563975, 17383.47849564515, 17388.304467821144, 17410.65178696419, 7858.607069646495, 8123.634436450374, 8167.264946154874, 8167.836643267101, 8171.264586187272, 7281.907713842966, 7464.402847772274, 7511.32398084175, 7515.8496830063095, 7544.3210111089165, 5289.735513224324, 5423.132298832168, 5434.83695489136, 5451.209574611659, 5467.863303417446, 1372.9519466818613, 1413.8939579531577, 1542.5372388283695, 1543.5909483986527, 1560.5084398414463, 879.0945326313907, 898.5552151684827, 905.2667339455063, 917.2936838634214, 930.0188301342014, 8299.95850020746, 8500.149985001573, 8506.191911768496, 8537.573121343908, 8538.786530336667, 724.6413025552386, 731.4221764805744, 732.2640746050185, 739.752183018684, 794.3367288314207, 5149.7940082397035, 5183.611229157828, 5280.551153151949, 5436.510714035756, 5657.038303488417, 21472.677909831364, 22216.333509994725, 22244.0, 22385.664215036788, 22623.0, 20555.794442055387, 21715.13139474435, 21753.347399578037, 21863.0, 21879.453013674785, 10816.891831081746, 10957.50691218897, 10960.671179864617, 10996.010359067563, 11049.613263535737, 8204.671813127408, 8250.339972802281, 8296.211859873303, 8448.0, 8650.78373040679, 18123.90938045354, 18428.907855461173, 18672.439826805217, 18890.622187556448, 19015.52461188481, 18967.05164741785, 18981.43055708331, 19177.52056198606, 19243.1340589671, 19401.417957461297, 10929.781404372026, 11035.834462482908, 11138.777224455627, 11147.554097835995, 11175.552977880794, 13599.796003059764, 13829.377678004314, 13834.93082534581, 13842.515511957436, 13858.792118118035, 11326.886731132912, 11432.314061156358, 11550.191486595857, 11602.94198529002, 11907.940460297643, 10996.340219586851, 11097.11223102166, 11219.326840389604, 11270.0, 11484.081273497934, 9955.800883982425, 10144.695659130239, 10144.79710405773, 10153.898461015295, 10246.129079028067, 7322.890156647548, 7335.339819416278, 7343.302386273295, 7374.594397308199, 7425.888611670721, 7515.173330933702, 7627.351675107678, 7657.195994420728, 7691.384689224737, 7755.3020228177475], "value": 6710.4630583375865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.4743067210104, 515.1860061103456, 533.3413234655201, 534.4468475128243, 544.4773017902816, 6165.53758468115, 6248.187735594366, 6324.272708638497, 6357.586756860806, 6370.745170193192, 6138.662373569452, 6206.7827626033095, 6224.906626400608, 6236.937630623693, 6275.5920865143735, 4990.4011518617635, 5077.33994580704, 5111.539961403473, 5138.922916156261, 5143.5113664201845, 5083.754480152368, 5105.693658380509, 5135.614828887829, 5167.328247327842, 5173.249878767577, 4988.201887697969, 5042.82350117746, 5054.646174767768, 5077.746112694369, 5098.782029817023, 5083.491650834924, 5100.132977393852, 5129.820456284049, 5165.431802501722, 5168.53483186515, 4614.953850461486, 4636.884077898079, 4654.627629789608, 4660.930086048712, 4666.230072038144, 6165.93441197195, 6168.568200225986, 6175.4442100210745, 6230.937690623081, 6268.746250749823, 5710.400407957146, 5801.941980580183, 5825.446582574648, 5830.300363956352, 5835.970820145914, 6594.439472644831, 6643.269240383554, 6703.262641109474, 6744.325567443266, 6755.763548275787, 4926.334944782444, 4931.950680493221, 4972.279019542182, 4981.825636102719, 4995.525425084611, 6950.721971121149, 6999.965000175018, 7012.193597736275, 7055.435565154827, 7113.288671132846, 5118.436971933084, 5123.385193776696, 5142.6914385137015, 5152.686065053387, 5177.534021938043, 5161.612879034087, 5185.662931909489, 5202.687838729688, 5226.634135610547, 5227.921581176285, 5505.476979686923, 5736.569757268222, 5737.0, 5754.7985820496915, 5824.864151490503, 6266.811995640138, 6567.802965911031, 6596.901046484307, 6625.204975402982, 6662.067310576524, 1754.2544418622035, 1755.6049888774924, 1777.7777777777778, 1784.4379020608467, 1793.5964408008094, 1208.1301462946665, 1217.1236709569096, 1217.7077501399601, 1218.9024878009739, 1268.67014576209, 5620.57845661577, 5623.718814059281, 5646.6894320811925, 5668.659880407189, 5683.54531637468, 6681.966590167115, 6745.8650826983185, 6798.422134118557, 6803.183617965876, 6866.622335771581, 5628.549716022709, 5675.679727359541, 5695.316562012585, 5700.6009579329875, 5730.885382292331, 3487.8256087195537, 3506.316268327703, 3545.840437180333, 3579.838907249128, 3587.954865726563, 6444.9355506444335, 6461.967690161613, 6480.0, 6513.967430162914, 6548.0, 6918.609881158196, 6924.0, 6944.548604340803, 6951.582905025714, 7074.540154889915, 6348.0959210086385, 6447.935520644827, 6475.370110371107, 6475.676216189172, 6497.902531462032, 6676.165479315086, 6735.595864248161, 6744.662766861539, 6749.966250168718, 6801.251862295045, 6755.628440435823, 6803.93196068033, 6807.89788153188, 6809.591424514545, 6839.179298484214, 6376.449420231945, 6528.706208220737, 6535.3464653534265, 6615.4376877965915, 6639.900401494078, 5044.319016932667, 5060.291559181644, 5085.46602606721, 5132.820351287687, 5149.459306772735, 6619.569727967667, 6661.433778128913, 6667.866642667216, 6791.3548212919695, 6793.218779840382, 6460.935390646221, 6461.289258181502, 6472.773452929125, 6498.837529061622, 6507.28419873823, 6565.898912348002, 6577.408033277028, 6579.769708060195, 6627.845950066151, 6672.0, 6372.992507360167, 6466.902996454963, 6500.902486462802, 6528.37980391862, 6580.012998050331, 6049.912780090862, 6404.967975160094, 6469.7412103515335, 6555.2789193187755, 6584.50616203777, 6176.857281402955, 6214.9067763984485, 6273.341299163704, 6330.797148541947, 6392.9360706392345], "value": 5103.853758525781, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.6325311742507, 907.6051917415929, 908.3278374003238, 912.5893347993405, 923.1691477670096, 18299.634007319844, 18866.622667546657, 19028.334008309714, 19410.417687469362, 19464.12411441485, 22495.66256506154, 22688.65967010492, 22699.659505107396, 22723.091076356966, 22734.54530909385, 947.2138125355938, 958.6692591056075, 960.6877764726491, 960.9807803843919, 964.0118878149882, 945.8723072385243, 988.9604415823394, 1007.3905287301187, 1008.8335424654923, 1009.328796350426, 1064.669952314781, 1077.7952189084049, 1078.250615822004, 1079.1906070447164, 1080.5407701726774, 1057.86776652918, 1066.0192622787054, 1066.6106870992032, 1066.7013236293851, 1067.066316972649, 771.8649236383667, 774.0131332551042, 774.8876412920094, 779.555653277632, 780.0444455541973, 19916.103775330146, 20266.898665506724, 20788.896055519777, 20803.791962080337, 21112.894435527724, 22110.0, 22385.55228895429, 22526.0, 22681.88659056711, 22736.0, 17995.280188792432, 18251.45245642633, 18280.0, 18286.63426731458, 18294.451166464893, 3273.0508152635944, 3369.7135743461836, 3748.4189950557434, 3793.715471339661, 3795.2788970095594, 142593.0, 143820.0, 146053.0, 147361.26319368443, 149909.0, 16771.0, 16967.830321696623, 17012.0, 17249.310027598756, 17335.133243337783, 30973.535396969062, 31015.844920775253, 31132.377352452822, 31564.36871262562, 31692.841535792173, 8284.46151000183, 8313.6674533018, 8353.081161072278, 8370.497770133812, 8426.620802063922, 3649.94525082124, 3809.4095415210686, 4043.9595604043584, 4104.363823607346, 4141.503019637663, 6137.877242455126, 6373.649449280334, 6397.584157029778, 6406.0, 6417.74329026843, 1202.6524115323218, 1214.7752665756864, 1234.5432190089725, 1235.2588446931768, 1245.078641805076, 682.1711620381261, 700.1178515071047, 702.3503259484957, 709.6558169287891, 712.9215786263507, 12268.0, 12833.422495987703, 13132.0, 13697.89278523154, 13770.104943178661, 654.715198888485, 659.5317324699421, 669.2504395077544, 669.7923643670478, 685.0170006041346, 5994.310654274727, 6020.909686354708, 6040.486558642565, 6084.30030546484, 6143.293521245025, 113443.0, 117442.0, 117557.0, 119242.40378798224, 121112.0, 112498.43750781193, 116309.0, 117491.0, 117921.4103929492, 120024.0, 93111.0, 94280.0, 96616.0, 98249.50875245577, 98601.99999999856, 11275.7744845101, 11423.0, 11608.101695761912, 11650.417479125841, 11793.11551633648, 45049.75956617038, 46697.53302466932, 46803.0, 47172.528274718185, 47278.52721472879, 57788.4221157783, 58810.0, 59284.70357648184, 59802.40197597969, 60851.0, 16560.337586496888, 16574.834251657812, 16982.23579938881, 17093.316267349168, 17121.97268163914, 19373.225070997567, 19512.21951121939, 19586.60826783485, 19598.0, 19910.0, 17520.123993800004, 17659.823401765818, 17681.734773978656, 17710.291588336837, 17795.644087118446, 17681.292748290438, 17692.380766673105, 17767.822321776617, 17786.911065445107, 17979.73030404571, 17319.480415587554, 17323.393681221096, 17398.478045658652, 17470.03914784699, 17571.385001524886, 12161.886520235885, 12641.747165056831, 12661.366931653565, 12866.35668216604, 12942.482300707867, 13328.600141995756, 13421.798673020108, 13569.52506662262, 13574.457021719021, 13615.798636225454], "value": 9374.991266806515, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 110.0, 108.0, 107.0, 111.0, 108.0, 108.0, 106.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 121.0, 118.0, 149.0, 122.0, 116.0, 120.0, 116.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 165.0, 164.0, 163.0, 168.0, 168.0, 173.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 76.0, 77.0, 75.0, 73.0, 74.0, 76.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 80.0, 79.0, 79.0, 78.0, 80.0, 144.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 113.0, 112.0, 112.0, 112.0, 112.0, 118.0, 111.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 152.0, 149.0, 147.0, 150.0, 149.0, 150.0, 148.0, 149.0, 148.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0, 94.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 54.0, 52.0, 53.0, 53.0, 54.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 38.0, 46.0, 37.0, 37.0, 37.0, 37.0, 40.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 78.0, 79.0, 74.0, 75.0, 84.0, 74.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 118.0, 112.0, 114.0, 114.0, 112.0, 115.0, 118.0, 111.0], "value": 114.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 174.0, 165.0, 165.0, 168.0, 176.0, 162.0, 162.0, 160.0, 161.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 62.0, 67.0, 63.0, 66.0, 64.0, 63.0, 63.0, 63.0], "value": 65.0, "unit": "score"}]}]} 09:29:02 INFO - Return code: 0 09:29:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:29:02 INFO - # TBPL SUCCESS # 09:29:02 INFO - Running post-action listener: _package_coverage_data 09:29:02 INFO - Running post-action listener: _resource_record_post_action 09:29:02 INFO - [mozharness: 2017-09-29 16:29:02.323643Z] Finished run-tests step (success) 09:29:02 INFO - Running post-run listener: _resource_record_post_run 09:29:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 151552; Write bytes: 343715840; Read time: 164; Write time: 237692 09:29:02 INFO - TinderboxPrint: CPU usage
13.1% 09:29:02 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 164 09:29:02 INFO - TinderboxPrint: I/O write bytes / time
343,715,840 / 237,692 09:29:02 INFO - TinderboxPrint: CPU idle
8,228.3 (86.9%) 09:29:02 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 09:29:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:29:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13217792; Read time: 0; Write time: 2260 09:29:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:29:02 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 147456; Write bytes: 330039296; Read time: 152; Write time: 235408 09:29:02 INFO - Running post-run listener: _upload_blobber_files 09:29:02 INFO - Blob upload gear active. 09:29:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:29:02 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 09:29:02 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'] 09:29:02 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 09:29:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 09:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 09:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:04 INFO - (blobuploader) - INFO - Done attempting. 09:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:06 INFO - (blobuploader) - INFO - Done attempting. 09:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 09:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 09:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:07 INFO - (blobuploader) - INFO - Done attempting. 09:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:29:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:14 INFO - (blobuploader) - INFO - Done attempting. 09:29:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:29:14 INFO - Return code: 0 09:29:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:29:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:29:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8758747a9aa638d2a4ec762ef54af47feb13a429b84353930d5ea1a97c142c05237fb8ee9b5c1bb53435119eb0b3c92087b3de90a75666969b11631d732e2b55", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a8ecea1ccd7e7f1ed9ca5645a9b47a14389c5390f66b26ee9a38265291d4e8e47050ec0ae6ebaf6722948b40b7d4f393d6361b2f71fd24b3487cc19ec01428", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47ac62a5bf52b9ad3bb808404b1004d3fa8a596747f1a374f9dd3e9ccdeb5d7f6d3635da169aa10a2afc3ed16f295a05052fc6d15b957951aa4899571d00daec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787ada094b45a1583e50033c2f47e6187e0e42d2321474721cd1c930439a912b6bbd1a01016ee19120f1a2e013d24392217c27b757734a17f0a78c013928746b"} 09:29:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:29:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:29:14 INFO - Contents: 09:29:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8758747a9aa638d2a4ec762ef54af47feb13a429b84353930d5ea1a97c142c05237fb8ee9b5c1bb53435119eb0b3c92087b3de90a75666969b11631d732e2b55", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a8ecea1ccd7e7f1ed9ca5645a9b47a14389c5390f66b26ee9a38265291d4e8e47050ec0ae6ebaf6722948b40b7d4f393d6361b2f71fd24b3487cc19ec01428", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47ac62a5bf52b9ad3bb808404b1004d3fa8a596747f1a374f9dd3e9ccdeb5d7f6d3635da169aa10a2afc3ed16f295a05052fc6d15b957951aa4899571d00daec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787ada094b45a1583e50033c2f47e6187e0e42d2321474721cd1c930439a912b6bbd1a01016ee19120f1a2e013d24392217c27b757734a17f0a78c013928746b"} 09:29:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:29:14 INFO - Copying logs to upload dir... 09:29:14 INFO - mkdir: /builds/slave/test/build/upload/logs 09:29:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.258946 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-29 09:29:14.690883) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 09:29:14.695292) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8758747a9aa638d2a4ec762ef54af47feb13a429b84353930d5ea1a97c142c05237fb8ee9b5c1bb53435119eb0b3c92087b3de90a75666969b11631d732e2b55", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a8ecea1ccd7e7f1ed9ca5645a9b47a14389c5390f66b26ee9a38265291d4e8e47050ec0ae6ebaf6722948b40b7d4f393d6361b2f71fd24b3487cc19ec01428", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47ac62a5bf52b9ad3bb808404b1004d3fa8a596747f1a374f9dd3e9ccdeb5d7f6d3635da169aa10a2afc3ed16f295a05052fc6d15b957951aa4899571d00daec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787ada094b45a1583e50033c2f47e6187e0e42d2321474721cd1c930439a912b6bbd1a01016ee19120f1a2e013d24392217c27b757734a17f0a78c013928746b"} build_url:https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/UiJi38FTSiS8xAy402WTnA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8758747a9aa638d2a4ec762ef54af47feb13a429b84353930d5ea1a97c142c05237fb8ee9b5c1bb53435119eb0b3c92087b3de90a75666969b11631d732e2b55", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3a8ecea1ccd7e7f1ed9ca5645a9b47a14389c5390f66b26ee9a38265291d4e8e47050ec0ae6ebaf6722948b40b7d4f393d6361b2f71fd24b3487cc19ec01428", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47ac62a5bf52b9ad3bb808404b1004d3fa8a596747f1a374f9dd3e9ccdeb5d7f6d3635da169aa10a2afc3ed16f295a05052fc6d15b957951aa4899571d00daec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787ada094b45a1583e50033c2f47e6187e0e42d2321474721cd1c930439a912b6bbd1a01016ee19120f1a2e013d24392217c27b757734a17f0a78c013928746b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 09:29:14.723550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:29:14.726880) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506698821.518216-186458102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 09:29:14.812296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 09:29:14.812667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 09:29:14.812985) ========= ========= Total master_lag: 0.44 =========