builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1501878140.37 results: success (0) revision: 4cfb674227051e22bab651e5759f3de503a50560 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.367305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.367869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.368215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.447404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.448064) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 13:22:20-- 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% 27.1M=0s 2017-08-04 13:22:20 (27.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.221043 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.708149) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.708484) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018008 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.783352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-04 13:22:20.783690) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4cfb674227051e22bab651e5759f3de503a50560 --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 4cfb674227051e22bab651e5759f3de503a50560 --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=8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 13:22:20,969 truncating revision to first 12 chars 2017-08-04 13:22:20,969 Setting DEBUG logging. 2017-08-04 13:22:20,969 attempt 1/10 2017-08-04 13:22:20,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4cfb67422705?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 13:22:21,523 unpacking tar archive at: mozilla-central-4cfb67422705/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975909 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-04 13:22:21.787024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.787336) ========= script_repo_revision: 4cfb674227051e22bab651e5759f3de503a50560 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.787725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.788004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.807904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-04 13:22:21.808351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:22:22 INFO - MultiFileLogger online at 20170804 13:22:22 in /builds/slave/test 13:22:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:22:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:22 INFO - {'append_to_log': False, 13:22:22 INFO - 'base_work_dir': '/builds/slave/test', 13:22:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:22:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:22 INFO - 'branch': 'Firefox-Non-PGO', 13:22:22 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:22 INFO - 'code_coverage': False, 13:22:22 INFO - 'config_files': ('talos/linux_config.py',), 13:22:22 INFO - 'default_actions': ('clobber', 13:22:22 INFO - 'read-buildbot-config', 13:22:22 INFO - 'download-and-extract', 13:22:22 INFO - 'populate-webroot', 13:22:22 INFO - 'create-virtualenv', 13:22:22 INFO - 'install', 13:22:22 INFO - 'setup-mitmproxy', 13:22:22 INFO - 'run-tests'), 13:22:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:22 INFO - 'disable_ccov_upload': False, 13:22:22 INFO - 'download_minidump_stackwalk': True, 13:22:22 INFO - 'download_symbols': 'ondemand', 13:22:22 INFO - 'enable_stylo': False, 13:22:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:22 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:22 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:22 INFO - 'gecko_profile': False, 13:22:22 INFO - 'gecko_profile_interval': 0, 13:22:22 INFO - 'installer_path': 'installer.exe', 13:22:22 INFO - 'log_level': 'info', 13:22:22 INFO - 'log_name': 'talos', 13:22:22 INFO - 'log_to_console': True, 13:22:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:22:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:22:22 INFO - 'opt_config_files': (), 13:22:22 INFO - 'pip_index': False, 13:22:22 INFO - 'suite': 'dromaeojs-e10s', 13:22:22 INFO - 'system_bits': '32', 13:22:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:22 INFO - 'title': 'talos-linux64-ix-089', 13:22:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:22 INFO - 'use_talos_json': True, 13:22:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:22 INFO - 'work_dir': 'build'} 13:22:22 INFO - [mozharness: 2017-08-04 20:22:22.172693Z] Running clobber step. 13:22:22 INFO - Running pre-action listener: _resource_record_pre_action 13:22:22 INFO - Running main action method: clobber 13:22:22 INFO - rmtree: /builds/slave/test/build 13:22:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:23 INFO - Running post-action listener: _resource_record_post_action 13:22:23 INFO - [mozharness: 2017-08-04 20:22:23.155465Z] Finished clobber step (success) 13:22:23 INFO - [mozharness: 2017-08-04 20:22:23.155567Z] Running read-buildbot-config step. 13:22:23 INFO - Running pre-action listener: _resource_record_pre_action 13:22:23 INFO - Running main action method: read_buildbot_config 13:22:23 INFO - Using buildbot properties: 13:22:23 INFO - { 13:22:23 INFO - "project": "", 13:22:23 INFO - "product": "firefox", 13:22:23 INFO - "who": "ryanvm@gmail.com", 13:22:23 INFO - "installer_path": "public/build/target.tar.bz2", 13:22:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:22:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:22:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:22:23 INFO - "stage_platform": "linux64", 13:22:23 INFO - "basedir": "/builds/slave/test", 13:22:23 INFO - "buildnumber": 1059, 13:22:23 INFO - "platform": "ubuntu64_hw", 13:22:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:22:23 INFO - "slavebuilddir": "test", 13:22:23 INFO - "taskId": "Mei08BPUQ_SorKj28W7hmw", 13:22:23 INFO - "branch": "mozilla-central", 13:22:23 INFO - "script_repo_revision": "production", 13:22:23 INFO - "revision": "4cfb674227051e22bab651e5759f3de503a50560", 13:22:23 INFO - "slavename": "talos-linux64-ix-089", 13:22:23 INFO - "repo_path": "mozilla-central" 13:22:23 INFO - } 13:22:23 INFO - Finding installer, test and symbols from parent task. 13:22:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mei08BPUQ_SorKj28W7hmw'}, attempt #1 13:22:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mei08BPUQ_SorKj28W7hmw'}, attempt #1 13:22:24 INFO - Task dependencies: fr-KaQa9SOOeGyxNTNR3Ww 13:22:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww'}, attempt #1 13:22:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json 13:22:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip 13:22:24 INFO - Running post-action listener: _resource_record_post_action 13:22:24 INFO - [mozharness: 2017-08-04 20:22:24.503309Z] Finished read-buildbot-config step (success) 13:22:24 INFO - [mozharness: 2017-08-04 20:22:24.503530Z] Running download-and-extract step. 13:22:24 INFO - Running pre-action listener: _resource_record_pre_action 13:22:24 INFO - Running main action method: download_and_extract 13:22:24 INFO - mkdir: /builds/slave/test/build/tests 13:22:24 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')]} 13:22:24 INFO - trying https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json 13:22:24 INFO - Downloading https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:22:25 INFO - Downloaded 989 bytes. 13:22:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:22:25 INFO - Using the following test package requirements: 13:22:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:22:25 INFO - u'common': [u'target.common.tests.zip'], 13:22:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:22:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:22:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:22:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:22:25 INFO - u'mozbase': [u'target.common.tests.zip'], 13:22:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:22:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:22:25 INFO - u'web-platform': [u'target.common.tests.zip', 13:22:25 INFO - u'target.web-platform.tests.tar.gz'], 13:22:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:22:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:22:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip 13:22:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:22:25 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip into memory 13:22:27 INFO - Content-Length response header: 54282413 13:22:27 INFO - Bytes received: 54282413 13:22:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:22:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip 13:22:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:22:38 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip into memory 13:22:40 INFO - Content-Length response header: 54282413 13:22:40 INFO - Bytes received: 54282413 13:22:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip 13:22:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:22:52 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip into memory 13:22:53 INFO - Content-Length response header: 14496008 13:22:53 INFO - Bytes received: 14496008 13:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:53 INFO - trying https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:53 INFO - Downloading https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:22:55 INFO - Downloaded 61895863 bytes. 13:22:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:55 INFO - mkdir: /builds/slave/test/properties 13:22:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:22:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:22:55 INFO - Contents: 13:22:55 INFO - build_url:https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:55 INFO - Running post-action listener: _resource_record_post_action 13:22:55 INFO - Running post-action listener: set_extra_try_arguments 13:22:55 INFO - [mozharness: 2017-08-04 20:22:55.883645Z] Finished download-and-extract step (success) 13:22:55 INFO - [mozharness: 2017-08-04 20:22:55.883874Z] Running populate-webroot step. 13:22:55 INFO - Running pre-action listener: _resource_record_pre_action 13:22:55 INFO - Running main action method: populate_webroot 13:22:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:22:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:22:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:22:55 INFO - 'tests': ['damp', 'tps']}, 13:22:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:22:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:22:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:22:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:22:55 INFO - 'other-e10s': {'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_many_windows', 13:22:55 INFO - 'sessionrestore_no_auto_restore', 13:22:55 INFO - 'tabpaint']}, 13:22:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:22:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:22:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:22:55 INFO - 'tsvgr_opacity', 13:22:55 INFO - 'tart', 13:22:55 INFO - 'tscrollx', 13:22:55 INFO - 'tsvg_static']}, 13:22:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:22:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:55 INFO - 'talos_options': ['--mitmproxy', 13:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:55 INFO - '--firstNonBlankPaint'], 13:22:55 INFO - 'tests': ['tp6_google', 13:22:55 INFO - 'tp6_youtube', 13:22:55 INFO - 'tp6_amazon', 13:22:55 INFO - 'tp6_facebook']}, 13:22:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:55 INFO - 'talos_options': ['--stylo', 13:22:55 INFO - '--mitmproxy', 13:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:55 INFO - '--firstNonBlankPaint'], 13:22:55 INFO - 'tests': ['tp6_google', 13:22:55 INFO - 'tp6_youtube', 13:22:55 INFO - 'tp6_amazon', 13:22:55 INFO - 'tp6_facebook']}, 13:22:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:55 INFO - 'talos_options': ['--stylo', 13:22:55 INFO - '--stylo-threads=1', 13:22:55 INFO - '--mitmproxy', 13:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:55 INFO - '--firstNonBlankPaint'], 13:22:55 INFO - 'tests': ['tp6_google', 13:22:55 INFO - 'tp6_youtube', 13:22:55 INFO - 'tp6_amazon', 13:22:55 INFO - 'tp6_facebook']}, 13:22:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:22:55 INFO - 'talos_options': ['--xperf_path', 13:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:55 INFO - 'tests': ['tp5n']}}} 13:22:55 INFO - Running post-action listener: _resource_record_post_action 13:22:55 INFO - [mozharness: 2017-08-04 20:22:55.903153Z] Finished populate-webroot step (success) 13:22:55 INFO - [mozharness: 2017-08-04 20:22:55.903243Z] Running create-virtualenv step. 13:22:55 INFO - Running pre-action listener: _resource_record_pre_action 13:22:55 INFO - Running main action method: create_virtualenv 13:22:55 INFO - Creating virtualenv /builds/slave/test/build/venv 13:22:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:22:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:22:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:22:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:22:56 INFO - Using real prefix '/usr' 13:22:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:22:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:22:58 INFO - Installing pip.................done. 13:22:58 INFO - Return code: 0 13:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:22:58 INFO - Reading from file tmpfile_stdout 13:22:58 INFO - Output received: 13:22:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:22:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:22: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')]} 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22: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')]} 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:22: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', 'pip>=1.5'] in /builds/slave/test/build 13:22: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 pip>=1.5 13:22:58 INFO - Using env: {'DISPLAY': ':0', 13:22:58 INFO - 'HOME': '/home/cltbld', 13:22:58 INFO - 'LANG': 'en_US.UTF-8', 13:22:58 INFO - 'LANGUAGE': 'en_US:en', 13:22:58 INFO - 'LOGNAME': 'cltbld', 13:22:58 INFO - 'MAIL': '/var/mail/cltbld', 13:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:58 INFO - 'MOZ_NO_REMOTE': '1', 13:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:58 INFO - 'NO_EM_RESTART': '1', 13:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:58 INFO - 'PWD': '/builds/slave/test', 13:22:58 INFO - 'SHELL': '/bin/bash', 13:22:58 INFO - 'SHLVL': '1', 13:22:58 INFO - 'TERM': 'linux', 13:22:58 INFO - 'TMOUT': '86400', 13:22:58 INFO - 'USER': 'cltbld', 13:22:58 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:58 INFO - '_': '/tools/buildbot/bin/python'} 13:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:22:59 INFO - Cleaning up... 13:22:59 INFO - Return code: 0 13:22:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:22:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:22:59 INFO - Using env: {'DISPLAY': ':0', 13:22:59 INFO - 'HOME': '/home/cltbld', 13:22:59 INFO - 'LANG': 'en_US.UTF-8', 13:22:59 INFO - 'LANGUAGE': 'en_US:en', 13:22:59 INFO - 'LOGNAME': 'cltbld', 13:22:59 INFO - 'MAIL': '/var/mail/cltbld', 13:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:59 INFO - 'MOZ_NO_REMOTE': '1', 13:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:59 INFO - 'NO_EM_RESTART': '1', 13:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:59 INFO - 'PWD': '/builds/slave/test', 13:22:59 INFO - 'SHELL': '/bin/bash', 13:22:59 INFO - 'SHLVL': '1', 13:22:59 INFO - 'TERM': 'linux', 13:22:59 INFO - 'TMOUT': '86400', 13:22:59 INFO - 'USER': 'cltbld', 13:22:59 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:59 INFO - '_': '/tools/buildbot/bin/python'} 13:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:59 INFO - Downloading/unpacking psutil>=3.1.1 13:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:00 INFO - Installing collected packages: psutil 13:23:00 INFO - Running setup.py install for psutil 13:23:00 INFO - building 'psutil._psutil_linux' extension 13:23:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:23:01 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 13:23:01 INFO - building 'psutil._psutil_posix' extension 13:23:01 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 13:23:01 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 13:23:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:01 INFO - Successfully installed psutil 13:23:01 INFO - Cleaning up... 13:23:01 INFO - Return code: 0 13:23:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:23:01 INFO - Using env: {'DISPLAY': ':0', 13:23:01 INFO - 'HOME': '/home/cltbld', 13:23:01 INFO - 'LANG': 'en_US.UTF-8', 13:23:01 INFO - 'LANGUAGE': 'en_US:en', 13:23:01 INFO - 'LOGNAME': 'cltbld', 13:23:01 INFO - 'MAIL': '/var/mail/cltbld', 13:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:01 INFO - 'MOZ_NO_REMOTE': '1', 13:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:01 INFO - 'NO_EM_RESTART': '1', 13:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:01 INFO - 'PWD': '/builds/slave/test', 13:23:01 INFO - 'SHELL': '/bin/bash', 13:23:01 INFO - 'SHLVL': '1', 13:23:01 INFO - 'TERM': 'linux', 13:23:01 INFO - 'TMOUT': '86400', 13:23:01 INFO - 'USER': 'cltbld', 13:23:01 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:01 INFO - '_': '/tools/buildbot/bin/python'} 13:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:23:03 INFO - Installing collected packages: mozsystemmonitor 13:23:03 INFO - Running setup.py install for mozsystemmonitor 13:23:03 INFO - Successfully installed mozsystemmonitor 13:23:03 INFO - Cleaning up... 13:23:03 INFO - Return code: 0 13:23:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:23:03 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')]} 13:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:03 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')]} 13:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:03 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:03 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 13:23:03 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 13:23:03 INFO - Using env: {'DISPLAY': ':0', 13:23:03 INFO - 'HOME': '/home/cltbld', 13:23:03 INFO - 'LANG': 'en_US.UTF-8', 13:23:03 INFO - 'LANGUAGE': 'en_US:en', 13:23:03 INFO - 'LOGNAME': 'cltbld', 13:23:03 INFO - 'MAIL': '/var/mail/cltbld', 13:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:03 INFO - 'MOZ_NO_REMOTE': '1', 13:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:03 INFO - 'NO_EM_RESTART': '1', 13:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:03 INFO - 'PWD': '/builds/slave/test', 13:23:03 INFO - 'SHELL': '/bin/bash', 13:23:03 INFO - 'SHLVL': '1', 13:23:03 INFO - 'TERM': 'linux', 13:23:03 INFO - 'TMOUT': '86400', 13:23:03 INFO - 'USER': 'cltbld', 13:23:03 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:03 INFO - '_': '/tools/buildbot/bin/python'} 13:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:03 INFO - Downloading/unpacking jsonschema==2.5.1 13:23: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 13:23: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 13:23: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 13:23: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 13:23:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:23: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 13:23: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 13:23: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 13:23: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 13:23:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:04 INFO - warning: no files found matching '*.txt' 13:23:04 INFO - no previously-included directories found matching 'build' 13:23:04 INFO - no previously-included directories found matching 'dist' 13:23:04 INFO - no previously-included directories found matching '.git*' 13:23:04 INFO - Installing collected packages: jsonschema, functools32 13:23:04 INFO - Running setup.py install for functools32 13:23:04 INFO - warning: no files found matching '*.txt' 13:23:04 INFO - no previously-included directories found matching 'build' 13:23:04 INFO - no previously-included directories found matching 'dist' 13:23:04 INFO - no previously-included directories found matching '.git*' 13:23:04 INFO - Successfully installed jsonschema functools32 13:23:04 INFO - Cleaning up... 13:23:04 INFO - Return code: 0 13:23:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:23:04 INFO - Using env: {'DISPLAY': ':0', 13:23:04 INFO - 'HOME': '/home/cltbld', 13:23:04 INFO - 'LANG': 'en_US.UTF-8', 13:23:04 INFO - 'LANGUAGE': 'en_US:en', 13:23:04 INFO - 'LOGNAME': 'cltbld', 13:23:04 INFO - 'MAIL': '/var/mail/cltbld', 13:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:04 INFO - 'MOZ_NO_REMOTE': '1', 13:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:04 INFO - 'NO_EM_RESTART': '1', 13:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:04 INFO - 'PWD': '/builds/slave/test', 13:23:04 INFO - 'SHELL': '/bin/bash', 13:23:04 INFO - 'SHLVL': '1', 13:23:04 INFO - 'TERM': 'linux', 13:23:04 INFO - 'TMOUT': '86400', 13:23:04 INFO - 'USER': 'cltbld', 13:23:04 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:04 INFO - '_': '/tools/buildbot/bin/python'} 13:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:23:05 INFO - Cleaning up... 13:23:05 INFO - Return code: 0 13:23:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:23:05 INFO - Using env: {'DISPLAY': ':0', 13:23:05 INFO - 'HOME': '/home/cltbld', 13:23:05 INFO - 'LANG': 'en_US.UTF-8', 13:23:05 INFO - 'LANGUAGE': 'en_US:en', 13:23:05 INFO - 'LOGNAME': 'cltbld', 13:23:05 INFO - 'MAIL': '/var/mail/cltbld', 13:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:05 INFO - 'MOZ_NO_REMOTE': '1', 13:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:05 INFO - 'NO_EM_RESTART': '1', 13:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:05 INFO - 'PWD': '/builds/slave/test', 13:23:05 INFO - 'SHELL': '/bin/bash', 13:23:05 INFO - 'SHLVL': '1', 13:23:05 INFO - 'TERM': 'linux', 13:23:05 INFO - 'TMOUT': '86400', 13:23:05 INFO - 'USER': 'cltbld', 13:23:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:05 INFO - '_': '/tools/buildbot/bin/python'} 13:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - Downloading docopt-0.6.1.tar.gz 13:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:06 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:06 INFO - Running setup.py install for blobuploader 13:23:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:07 INFO - Running setup.py install for requests 13:23:07 INFO - Running setup.py install for docopt 13:23:07 INFO - Successfully installed blobuploader requests docopt 13:23:07 INFO - Cleaning up... 13:23:07 INFO - Return code: 0 13:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:07 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:07 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 13:23:07 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 13:23:07 INFO - Using env: {'DISPLAY': ':0', 13:23:07 INFO - 'HOME': '/home/cltbld', 13:23:07 INFO - 'LANG': 'en_US.UTF-8', 13:23:07 INFO - 'LANGUAGE': 'en_US:en', 13:23:07 INFO - 'LOGNAME': 'cltbld', 13:23:07 INFO - 'MAIL': '/var/mail/cltbld', 13:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:07 INFO - 'MOZ_NO_REMOTE': '1', 13:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:07 INFO - 'NO_EM_RESTART': '1', 13:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:07 INFO - 'PWD': '/builds/slave/test', 13:23:07 INFO - 'SHELL': '/bin/bash', 13:23:07 INFO - 'SHLVL': '1', 13:23:07 INFO - 'TERM': 'linux', 13:23:07 INFO - 'TMOUT': '86400', 13:23:07 INFO - 'USER': 'cltbld', 13:23:07 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:07 INFO - '_': '/tools/buildbot/bin/python'} 13:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:07 INFO - Running setup.py (path:/tmp/pip-TmgIam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:07 INFO - Running setup.py (path:/tmp/pip-uIYc9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:07 INFO - Running setup.py (path:/tmp/pip-3XOjMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:07 INFO - Running setup.py (path:/tmp/pip-pYJ6Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:08 INFO - Running setup.py (path:/tmp/pip-ApK6ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:08 INFO - Running setup.py (path:/tmp/pip-W0LFLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:08 INFO - Running setup.py (path:/tmp/pip-TjRfEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:08 INFO - Running setup.py (path:/tmp/pip-LLns9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:08 INFO - Running setup.py (path:/tmp/pip-ACIXo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:08 INFO - Running setup.py (path:/tmp/pip-AKOD4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:08 INFO - Running setup.py (path:/tmp/pip-0VIUCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:08 INFO - Running setup.py (path:/tmp/pip-BwmqFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:08 INFO - Running setup.py (path:/tmp/pip-KEO3nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:08 INFO - Running setup.py (path:/tmp/pip-vk92O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:08 INFO - Running setup.py (path:/tmp/pip-lXVZeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:08 INFO - Running setup.py (path:/tmp/pip-iX3Ymu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:08 INFO - Running setup.py (path:/tmp/pip-ztWtQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:08 INFO - Running setup.py install for manifestparser 13:23:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozcrash 13:23:09 INFO - Running setup.py install for mozdebug 13:23:09 INFO - Running setup.py install for mozdevice 13:23:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozfile 13:23:09 INFO - Running setup.py install for mozhttpd 13:23:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozinfo 13:23:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozInstall 13:23:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozleak 13:23:09 INFO - Running setup.py install for mozlog 13:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Running setup.py install for moznetwork 13:23:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Running setup.py install for mozprocess 13:23:10 INFO - Running setup.py install for mozprofile 13:23:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Running setup.py install for mozrunner 13:23:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Running setup.py install for mozscreenshot 13:23:10 INFO - Running setup.py install for moztest 13:23:10 INFO - Running setup.py install for mozversion 13:23:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:10 INFO - Cleaning up... 13:23:10 INFO - Return code: 0 13:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:10 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')]} 13:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:10 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')]} 13:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:10 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:10 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 13:23:10 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 13:23:10 INFO - Using env: {'DISPLAY': ':0', 13:23:10 INFO - 'HOME': '/home/cltbld', 13:23:10 INFO - 'LANG': 'en_US.UTF-8', 13:23:10 INFO - 'LANGUAGE': 'en_US:en', 13:23:10 INFO - 'LOGNAME': 'cltbld', 13:23:10 INFO - 'MAIL': '/var/mail/cltbld', 13:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:10 INFO - 'MOZ_NO_REMOTE': '1', 13:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:10 INFO - 'NO_EM_RESTART': '1', 13:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:10 INFO - 'PWD': '/builds/slave/test', 13:23:10 INFO - 'SHELL': '/bin/bash', 13:23:10 INFO - 'SHLVL': '1', 13:23:10 INFO - 'TERM': 'linux', 13:23:10 INFO - 'TMOUT': '86400', 13:23:10 INFO - 'USER': 'cltbld', 13:23:10 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:10 INFO - '_': '/tools/buildbot/bin/python'} 13:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:10 INFO - Running setup.py (path:/tmp/pip-EPJYMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:11 INFO - Running setup.py (path:/tmp/pip-Vjf4Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:11 INFO - Running setup.py (path:/tmp/pip-Tydtek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:11 INFO - Running setup.py (path:/tmp/pip-9Rx9sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:11 INFO - Running setup.py (path:/tmp/pip-eJA0te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:11 INFO - Running setup.py (path:/tmp/pip-q7QSVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:11 INFO - Running setup.py (path:/tmp/pip-T5gqRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:11 INFO - Running setup.py (path:/tmp/pip-P8K7NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:11 INFO - Running setup.py (path:/tmp/pip-eyD9MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:11 INFO - Running setup.py (path:/tmp/pip-dFfWRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:11 INFO - Running setup.py (path:/tmp/pip-DSJ95Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:11 INFO - Running setup.py (path:/tmp/pip-o5M6wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:11 INFO - Running setup.py (path:/tmp/pip-IutSCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:11 INFO - Running setup.py (path:/tmp/pip-ncdxdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:11 INFO - Running setup.py (path:/tmp/pip-N8vQtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:12 INFO - Running setup.py (path:/tmp/pip-SqJAWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:12 INFO - Running setup.py (path:/tmp/pip-m7uOCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:23:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:13 INFO - Downloading blessings-1.6.tar.gz 13:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:13 INFO - Installing collected packages: blessings 13:23:13 INFO - Running setup.py install for blessings 13:23:13 INFO - Successfully installed blessings 13:23:13 INFO - Cleaning up... 13:23:13 INFO - Return code: 0 13:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:13 INFO - Reading from file tmpfile_stdout 13:23:13 INFO - Current package versions: 13:23:13 INFO - argparse == 1.2.1 13:23:13 INFO - blessings == 1.6 13:23:13 INFO - blobuploader == 1.2.4 13:23:13 INFO - docopt == 0.6.1 13:23:13 INFO - functools32 == 3.2.3-2 13:23:13 INFO - jsonschema == 2.5.1 13:23:13 INFO - manifestparser == 1.1 13:23:13 INFO - mozInstall == 1.13 13:23:13 INFO - mozcrash == 1.0 13:23:13 INFO - mozdebug == 0.1 13:23:13 INFO - mozdevice == 0.51 13:23:13 INFO - mozfile == 1.2 13:23:13 INFO - mozhttpd == 0.7 13:23:13 INFO - mozinfo == 0.10 13:23:13 INFO - mozleak == 0.1 13:23:13 INFO - mozlog == 3.5 13:23:13 INFO - moznetwork == 0.27 13:23:13 INFO - mozprocess == 0.25 13:23:13 INFO - mozprofile == 0.28 13:23:13 INFO - mozrunner == 6.13 13:23:13 INFO - mozscreenshot == 0.1 13:23:13 INFO - mozsystemmonitor == 0.3 13:23:13 INFO - moztest == 0.8 13:23:13 INFO - mozversion == 1.4 13:23:13 INFO - psutil == 3.1.1 13:23:13 INFO - requests == 1.2.3 13:23:13 INFO - wsgiref == 0.1.2 13:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23: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')]} 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:13 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:13 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 13:23:13 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 13:23:13 INFO - Using env: {'DISPLAY': ':0', 13:23:13 INFO - 'HOME': '/home/cltbld', 13:23:13 INFO - 'LANG': 'en_US.UTF-8', 13:23:13 INFO - 'LANGUAGE': 'en_US:en', 13:23:13 INFO - 'LOGNAME': 'cltbld', 13:23:13 INFO - 'MAIL': '/var/mail/cltbld', 13:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:13 INFO - 'MOZ_NO_REMOTE': '1', 13:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:13 INFO - 'NO_EM_RESTART': '1', 13:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:13 INFO - 'PWD': '/builds/slave/test', 13:23:13 INFO - 'SHELL': '/bin/bash', 13:23:13 INFO - 'SHLVL': '1', 13:23:13 INFO - 'TERM': 'linux', 13:23:13 INFO - 'TMOUT': '86400', 13:23:13 INFO - 'USER': 'cltbld', 13:23:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:13 INFO - '_': '/tools/buildbot/bin/python'} 13:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:23:15 INFO - Installing collected packages: simplejson 13:23:15 INFO - Running setup.py install for simplejson 13:23:15 INFO - building 'simplejson._speedups' extension 13:23:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 13:23:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 13:23:16 INFO - Successfully installed simplejson 13:23:16 INFO - Cleaning up... 13:23:16 INFO - Return code: 0 13:23:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2383a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', '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 13:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:23:16 INFO - Using env: {'DISPLAY': ':0', 13:23:16 INFO - 'HOME': '/home/cltbld', 13:23:16 INFO - 'LANG': 'en_US.UTF-8', 13:23:16 INFO - 'LANGUAGE': 'en_US:en', 13:23:16 INFO - 'LOGNAME': 'cltbld', 13:23:16 INFO - 'MAIL': '/var/mail/cltbld', 13:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:16 INFO - 'MOZ_NO_REMOTE': '1', 13:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:16 INFO - 'NO_EM_RESTART': '1', 13:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:16 INFO - 'PWD': '/builds/slave/test', 13:23:16 INFO - 'SHELL': '/bin/bash', 13:23:16 INFO - 'SHLVL': '1', 13:23:16 INFO - 'TERM': 'linux', 13:23:16 INFO - 'TMOUT': '86400', 13:23:16 INFO - 'USER': 'cltbld', 13:23:16 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:16 INFO - '_': '/tools/buildbot/bin/python'} 13:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:23:16 INFO - Cleaning up... 13:23:16 INFO - Return code: 0 13:23:16 INFO - Running post-action listener: _resource_record_post_action 13:23:16 INFO - Running post-action listener: _start_resource_monitoring 13:23:16 INFO - Starting resource monitoring. 13:23:16 INFO - [mozharness: 2017-08-04 20:23:16.438857Z] Finished create-virtualenv step (success) 13:23:16 INFO - [mozharness: 2017-08-04 20:23:16.439825Z] Running install step. 13:23:16 INFO - Running pre-action listener: _resource_record_pre_action 13:23:16 INFO - Running main action method: install 13:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:16 INFO - Reading from file tmpfile_stdout 13:23:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:16 INFO - Reading from file tmpfile_stdout 13:23:16 INFO - Output received: 13:23:16 INFO - Usage: mozinstall [options] installer 13:23:16 INFO - Options: 13:23:16 INFO - -h, --help show this help message and exit 13:23:16 INFO - -d DEST, --destination=DEST 13:23:16 INFO - Directory to install application into. [default: 13:23:16 INFO - "/builds/slave/test"] 13:23:16 INFO - --app=APP Application being installed. [default: firefox] 13:23:16 INFO - mkdir: /builds/slave/test/build/application 13:23:16 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'] 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:23:34 INFO - Reading from file tmpfile_stdout 13:23:34 INFO - Output received: 13:23:34 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:34 INFO - Running post-action listener: _resource_record_post_action 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.726720Z] Finished install step (success) 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.727007Z] Running setup-mitmproxy step. 13:23:34 INFO - Running pre-action listener: _resource_record_pre_action 13:23:34 INFO - Running main action method: setup_mitmproxy 13:23:34 INFO - Skipping: mitmproxy is not required 13:23:34 INFO - Running post-action listener: _resource_record_post_action 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.728166Z] Finished setup-mitmproxy step (success) 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.728389Z] Running run-tests step. 13:23:34 INFO - Running pre-action listener: _resource_record_pre_action 13:23:34 INFO - Running pre-action listener: _set_gcov_prefix 13:23:34 INFO - Running main action method: run_tests 13:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:34 INFO - Python 2.7.3 13:23:34 INFO - Return code: 0 13:23:34 INFO - grabbing minidump binary from tooltool 13:23:34 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')]} 13:23:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2523eb0>, '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 0x2524db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 13:23:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:23:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 13:23:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:34 INFO - Return code: 0 13:23:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:34 INFO - ENV: RUST_BACKTRACE is now 1 13:23:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:23:34 INFO - Using env: {'DISPLAY': ':0', 13:23:34 INFO - 'HOME': '/home/cltbld', 13:23:34 INFO - 'LANG': 'en_US.UTF-8', 13:23:34 INFO - 'LANGUAGE': 'en_US:en', 13:23:34 INFO - 'LOGNAME': 'cltbld', 13:23:34 INFO - 'MAIL': '/var/mail/cltbld', 13:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:34 INFO - 'MOZ_NO_REMOTE': '1', 13:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:34 INFO - 'NO_EM_RESTART': '1', 13:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:34 INFO - 'PWD': '/builds/slave/test', 13:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:34 INFO - 'RUST_BACKTRACE': '1', 13:23:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:23:34 INFO - 'SHELL': '/bin/bash', 13:23:34 INFO - 'SHLVL': '1', 13:23:34 INFO - 'TERM': 'linux', 13:23:34 INFO - 'TMOUT': '86400', 13:23:34 INFO - 'USER': 'cltbld', 13:23:34 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000', 13:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:34 INFO - '_': '/tools/buildbot/bin/python'} 13:23:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:23:35 INFO - mozversion application_buildid: 20170804193407 13:23:35 INFO - mozversion application_changeset: 4cfb674227051e22bab651e5759f3de503a50560 13:23:35 INFO - mozversion application_display_name: Nightly 13:23:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:35 INFO - mozversion application_name: Firefox 13:23:35 INFO - mozversion application_remotingname: firefox 13:23:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:23:35 INFO - mozversion application_vendor: Mozilla 13:23:35 INFO - mozversion application_version: 57.0a1 13:23:35 INFO - mozversion platform_buildid: 20170804193407 13:23:35 INFO - mozversion platform_changeset: 4cfb674227051e22bab651e5759f3de503a50560 13:23:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:23:35 INFO - mozversion platform_version: 57.0a1 13:23:35 INFO - using testdate: 1501878215 13:23:35 INFO - actual date: 1501878215 13:23:35 INFO - starting webserver on 'localhost:47066' 13:23:35 INFO - SUITE-START | Running 2 tests 13:23:35 INFO - TEST-START | dromaeo_css 13:23:35 INFO - Initialising browser for dromaeo_css test... 13:23:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47066/getInfo.html -profile /tmp/tmpNOHXxa/profile 13:23:35 INFO - TEST-INFO | started process 3338 (/builds/slave/test/build/application/firefox/firefox http://localhost:47066/getInfo.html) 13:23:42 INFO - TEST-INFO | 3338: exit 0 13:23:42 INFO - Browser initialized. 13:23:42 INFO - Running cycle 1/1 for dromaeo_css test... 13:23:42 INFO - TEST-INFO | started process 3544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOHXxa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:23:43 INFO - PID 3544 | 13:23:43 INFO - PID 3544 | (/builds/slave/test/build/application/firefox/firefox:3592): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:23:43 INFO - PID 3544 | 13:23:53 INFO - PID 3544 | RSS: Main: 170827776 13:23:53 INFO - PID 3544 | 13:26:53 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47066/tests/dromaeo/cssquery-ext.html) 13:26:54 INFO - PID 3544 | RSS: Main: 172687360 13:26:54 INFO - PID 3544 | 13:29:56 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47066/tests/dromaeo/cssquery-ext.html (next: http://localhost:47066/tests/dromaeo/cssquery-jquery.html) 13:29:56 INFO - PID 3544 | RSS: Main: 170201088 13:29:56 INFO - PID 3544 | 13:32:58 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47066/tests/dromaeo/cssquery-mootools.html) 13:32:59 INFO - PID 3544 | RSS: Main: 171122688 13:32:59 INFO - PID 3544 | 13:36:00 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47066/tests/dromaeo/cssquery-prototype.html) 13:36:01 INFO - PID 3544 | RSS: Main: 171040768 13:36:01 INFO - PID 3544 | 13:39:05 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47066/tests/dromaeo/cssquery-yui.html) 13:39:05 INFO - PID 3544 | RSS: Main: 174055424 13:39:05 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47066/tests/dromaeo/cssquery-yui.html (next: http://localhost:47066/tests/dromaeo/cssquery-dojo.html) 13:42:07 INFO - PID 3544 | RSS: Main: 174718976 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | __start_tp_report 13:42:07 INFO - PID 3544 | _x_x_mozilla_page_load 13:42:07 INFO - PID 3544 | _x_x_mozilla_page_load_details 13:42:07 INFO - PID 3544 | |i|pagename|runs| 13:42:07 INFO - PID 3544 | |0;dojo.html;3161.7944833585802;3179.618445786505;3181.1569933967494;3204.375146846363;3229.6124465064195;6174.10475481055;6271.4042165994215;6273.874522509553;6301.2753533343675;6339.175907132078;6085.148079268894;6171.352008039158;6191.814245572628;6192.102145188945;6248.37516248375;5680.573956953234;5709.685967271798;5715.257016587838;5729.39841316662;5765.1352297155345;5726.055200891848;5736.196932429442;5744.712764361786;5766.365699773021;5852.4440178183;5695.572832037593;5695.857603559903;5755.366909639936;5774.1050137228585;5791.623544469596;5490.725463726838;5575.358833734132;5623.606347555673;5646.632968857011;5680.375158732536;5642.520385767215;5691.174779656968;5703;5730.6275092119295;5732.799352022701;6111.35830737775;6118.051701986199;6185.690715464209;6208.751649933997;6244.3755624437645;6512.544121911468;6626.370494802986;6649.235337936151;6652.667366631697;6777.559458635223;6719.563228390139;6722.495812814059;6731.225909020476;6739.561928474683;6746.055552222692;6214.875702485971;6243.438090571825;6257.7184026718905;6281.874362512815;6304.211973503312;6686.866262674816;6698.698558564876;6777.49168812341;6806.829829254309;6815.045893574904;6377.585456945284;6380.330065343072;6464.25661048976;6471.579347342407;6515.250746164157;6519.942239705261;6542.869142617121;6551.050097735897;6646.936490161647;6667.766628167991;6727.730890764413;6750.426213771786;6751.696173672197;6777.1189745332795;6810.046593476917;6733.8653226935185;6816.07982922309;6817.659117044128;6818.318168183142;6828.2147553031045;5457.945420545823;5486.1222204447895;5545.445455454503;5549.472800083986;5558.666480011131;4630.398048253773;4653.395058642423;4718.197906355859;4720.33915251865;4759.571638552547;5797.536197104221;5904.0553511437965;5928.318243402064;5928.881422371528;5930.080837470199;6767.052612634235;6785.525013249124;6791.728330866808;6808.11494505721;6905.343992320722;5777.0467872801355;5837.09525023622;5844.298684157929;5927.881442371128;5931.673757943268;5935.347111817697;5938.406159384027;5952.7023648817385;5999.040153575407;6025.15647809307;6510.934890651128;6525.575837570543;6540.967295163494;6548.508861835381;6572.277049524549;6634.336566343327;6749.595024298558;6752;6801.727930882709;6829.736498747748;6408.391202835724;6504.869902601827;6506.902396464152;6593.274739778524;6595.241547221939;6532.640704761094;6564.245111812203;6576.76981305652;6581.868362632817;6591.373819487141;6631.767888123893;6707.027481015323;6715.3620406061345;6740.460763139035;6820.795376138723;6547.508936829661;6590.110335104891;6603.2406273277265;6611.570247934062;6634.933650663432;6527.738890444519;6531.771388001397;6618.7352505899225;6621;6645.534812563267;6330.208723909512;6447.9032814508755;6459;6557.180352455943;6558.8360290991195;6471.870562588816;6543.836404089936;6572.605643661395;6597.2742998271115;6606.966965165144;6193.287771906288;6316.778912738032;6340.619562826245;6360.045993101072;6377 13:42:07 INFO - PID 3544 | |1;ext.html;846.7756044648165;852.9317654587634;877.736678996301;905.836949349117;907.3512438606396;42247;42907;42954;43121.784391078;43297.78351108244;38798.22403551927;39347.21305573887;39380.606193938125;39404.40893386595;39413.60586394135;7069.363757261845;7202.4958252922315;7204.747833825817;7208.49540532163;7210;7057.223705392403;7117.2882711728935;7151.535150215245;7158.427325813923;7159.964200178992;7120.323569260938;7154.713811447536;7156.749513767019;7161.069061022086;7165.9283407165785;7001.929980700179;7027.016217729548;7041.823954401129;7051;7101.11236095488;6478.416942475153;6490.253620833618;6508.772192973223;6547.967260163717;6570.375814297634;34201;34310.31379372399;34517;34520.48219276713;34520.48219276713;3363.814990175539;3364.7308215342714;3401.183715908189;3403.1662242750435;3408.625051244361;26760;26800.86599567009;26814.5977810333;26849.194524164308;26939.865300673566;4444.466664000308;4462.419885414908;4478.596926276651;4506.8873278167985;4512.661550383735;186673;188173;188338;188699;188957;22093.668594971088;22103.778962210174;22146;22185.223517176822;22202.777972220396;22577.548449030928;22610.773892261197;22622.773772262397;22662;22679.319620411414;13435.328233588281;13672.248026358646;13672.384742686603;13687.178769273876;13702.52041178554;13577.389017494237;13584.456621735217;13587.59237222885;13601.387937542637;13604.591862243951;5858.091995740667;5910.645361278337;5961.344252132262;5962.970185149046;6013.759449622054;2430.2709187243754;2441.4140606254728;2489.253224032783;2499.7750202481866;2513.308840068996;1012.5899010900597;1013.2805707947292;1014.8934361891895;1024.9692509224735;1030.5929157982555;22975.540489190458;23176;23367.649485257734;23368.64947025796;23491.17780877661;1117.273772048159;1123.3428444359977;1123.6572845282103;1124.6007667277997;1126.2172789911097;12238.694032649255;12291.446884890202;12334.198277111958;12400.19398739079;12440.315782632042;224024;224142;224784;224997;225198;53138;53194.468055319725;53969.46030539723;57823;57935.42064579385;1473.6389584551853;1488.263309661746;1499.3028241867366;1504.9849501504846;1505.4279373837871;27218.5917211238;27326.45347093087;27566.862165689847;27890.72109278881;28151.57772633371;51576.74211628918;51736.74131629318;51738;51795.74102129465;51870.48129518657;196740;197374;197628;198013;198388;34637.65362346344;34683;34684.82657586797;34761.82619086889;35028.64971350254;44055;46930.29604555866;48772.26841597308;49024.50975490342;49389.75305123451;34093.31813363769;34545.654543455246;34811.47782783311;35305.293894122486;35759;34302.48546271858;34493;34581;34581.654183457846;35453.46819797757;37585.81207093947;37902.62097378991;38039;38047.42928856014;38068.42897356486;33814.15464613306;33982.49026264559;34485.310293794486;34589.82705086459;34611;24422.389440264134;24576.511923450842;24619.507609847344;24806.627900581865;24970.500589988464 13:42:07 INFO - PID 3544 | |2;jquery.html;581.9534437245021;591.624318557716;593.1073734030284;605.791002104274;611.9755209791608;22563.661545076815;22976;23497;23499.29502114937;23612.173573924916;26301.210963671074;26811.865940670268;26937.86531067342;26983.865080674568;26996;6514.250861150981;6673.833154171136;6680.131582894217;6687.866242675143;6695.698693558801;6186.628802271855;6547.9017814732815;6623.205215374138;6630.3701148391065;6654;6542.967285163568;6544.247411547685;6549.836254093638;6550.443212326934;6563.507736919726;6496.837579060514;6520.380563846427;6525.575837570566;6529.706163222642;6531.93468065318;5980.073088671263;6002.939970600281;6012.879742405171;6018.368071352533;6041.365656606081;27250.45499090007;30175.849120754476;30771.538426923613;30965.690343096507;31268;1940.0978544976654;1976.416956997689;1984.7320611717378;1987.8012198780007;1987.8906660133687;19737.80262197374;20201.0909509071;20211.494712632153;20237.696434553494;20248;2325.476767727248;2389.617661174204;2398.1126983016397;2424.6120620700603;2444.6821913151352;134142;136112.31943840216;136535;137736;140260;14764.409423622934;14874.405023799143;15498;15507.534773956799;15638.2180890955;24053;24104;24190.758092419204;24256.75743242545;24306.635400469007;10566.260361774603;10722.678319650424;10852.891471085188;10898.891011089947;10918.890811091946;10037.598496060076;10121.69634910954;10151.898481015096;10189.133923616428;10260.179185665129;8935.034292455779;9000.774980625405;9103.590338434786;9207.355485115977;9429.811403771886;2777.847218402967;2789.986050069737;2813.887444502197;2824.8163869348427;2870.885164593393;960.5485421851719;969.1665167955553;979.2215188924822;982.5873133284038;989.5151375825793;19827.801721982883;19921.900390497955;19963.20147194125;20277.89861050715;20482.283120090724;1044.6604853422668;1047.2930771729204;1056.6248981611418;1061.0927656853435;1069.8341757027674;11242.213045086928;11534.077273818075;13266.40301186449;14087.436502539784;14309.9983001191;511144;514547;539581;540972;551144;116868.41565792117;122309.38845305717;123675.3816230913;124353.37823310826;124705.37647311705;1246.2148846227;1269.9492020319083;1297.8702129787134;1306.5296493262417;1308.1431662261234;21211.363659090253;21342.679859802425;21347.893260533598;21395.572088558452;21466.356009319745;56574.151387728394;57116.714416427654;57836.42163578478;58018.709906450196;59491.107633384665;72189;72513;72834;73053.634731826;74890;12683.682907927376;13185.802212967004;14589.635259118608;15032.549023529311;15034.624134396727;23011.309660710205;23991.52016959686;24027.51944961056;24351.634725479485;24511.142110026776;18993;19187.32844350441;19222.231110755412;19301.80698193;19325;16868.24092915797;17119.315227390765;17321.653566928842;17809.020503872413;18219.271229150687;19435.61128777445;20115.29596464117;20147.093380798193;20198.495037624176;20233;15031.098134111988;15155.393784248507;15271.312790924212;15300.540983770505;15351.23243837826;18236.17937192803;19041.143148558072;19120.80879191246;19248.518787029876;19258.325958591384 13:42:07 INFO - PID 3544 | |3;mootools.html;1371.3074897176925;1393.919712223027;1439.7120575884826;1445;1447.3993292783496;13380.665483362909;13531.797023044663;13850.307484625766;13878.444862205499;13905.374258158381;14170.645733856658;14528.128312301269;14536;14541.563753087397;14564.126152430861;2391.8445301055417;2440.694913135858;2446.0460420436043;2453.386653336666;2453.6810214672155;2321.4892723600783;2451.2278632230878;2506.5989441689335;2508.3227528567277;2514.9119780807673;2394.2936833634035;2426.575349313872;2427.174760581402;2427.2232885476656;2427.9635805462844;2372.252740386781;2374.382660508263;2411.3248290478696;2423.6243382275775;2424.7090349158125;2312.4681323295567;2324.32594547581;2335.2760644200184;2337.2170322941834;2340.461693810433;13393.866061339359;13738.519151829638;13770.24263665498;13772.449102035907;13784.310784460737;6771.695273712695;6954.930450695479;6984.930150698478;6995;7007.649617519103;4727.22000869856;4896.902061958776;4915.950840491585;5024.221245706921;5035.320231768701;1913.7033759767257;1914.4543805015644;1916.6358391905494;1974.2300502803919;1974.8518861085477;22591.322260332054;22604.095836166696;22777;22794;22811.31566053021;6404.5837020594445;6580.63806490638;6617.834554136185;6644.302348253461;6652.567583107082;14876.776848347283;15005.324760385809;15021.399144034116;15034.248287585577;15048.398064077313;7073.115860517435;7126.857462850714;7373.262673732691;7608.505447145918;7617.5048621839405;6681.866362672719;6769.93230067693;6789.966050169717;6926.307369263033;6980.860382792316;4467.419235499365;4569.885752856138;4728.645351598644;4821.662483626113;4884.853454396374;1261.6025951825145;1276.2215048820212;1297.1762930539176;1305.0799186573443;1322.9404676789568;899.6671231644202;918.5820451694597;920.2821798996794;927.5408672707053;935.8830146231721;8116.35069194463;8228.753137405887;8237.176282371835;8295.502269863828;8297.751067467985;979.4466126638426;990.5195979949718;998.1565577087349;1005.527402121002;1016.5222345497605;4550.772461376918;5525.806596769094;5564.582656300794;5657.4908258256955;5854.326752423441;18259.26962921495;18832.435026949213;19207.80792192088;19219.903900480407;19238.71141932872;18788.248470061044;18952.715709264372;19096.140673669717;19098;19107.617847643247;10406.479676016168;10692.89307106919;11077.833832492357;11145.83281250798;11203.21577489568;7988.640511177127;8247.257746802816;8500.234978851686;8535.786605334917;8543.401961862859;16388.26252818602;16802.57993550122;16898.915505422396;17107.743383849003;17147;17526.561835954202;17679;17751.378701745376;17763.289468421117;17865.553361165556;10640.414777187329;10988.615398461016;11083.72290692739;11418;11420.200585958903;11449.313041217554;11848;12049.33728644898;12243;12492.937535312265;10173.694789156338;10608.628697995533;10659.8934010662;10675.786484270426;10779.191560632828;10091.142252908292;10197.694069177936;10643.148548115978;10774.676759697222;10904.727381815517;9012.504312262889;9204.033576474641;9229.169374756304;9248.861267081134;9253.72238832836;7146.499745017799;7155.749548765768;7174.354308112295;7191.244919283609;7258.49190556656;7097.112860892388;7117.181524124792;7241.637918104179;7249.130104387507;7254.129504459499 13:42:07 INFO - PID 3544 | |4;prototype.html;502.05864004990656;508.26301862299675;532.270789019044;534.2787237229738;534.7620308962512;6084.9391506084985;6148.969255153724;6176.166217560628;6203.875922481548;6249.281332646747;5872.471477567018;5938.7624495020145;6015.548833837458;6043.637381757087;6069.814866648003;4914.827981020647;4925.458199598042;4959.305697202394;4972.875678108058;4976.452590215083;4906.803727850899;4936.481669424713;4953.851384458472;4987.426445958725;5011.141421105746;4791.257355109963;4850.684705494132;4894.3392641993405;4935.605151587883;4945.876353091166;4945.431275403339;4966.5778408835295;4967.7019378837385;4969.552740253394;4970.627202959792;4385.101054283864;4435.911281774379;4443.577860103285;4466.374707540915;4484.708493947883;5875.941240587582;5918.957959503964;5933.851653708649;5942.762289508414;5995.730192141364;5620.747066382022;5647.209390685307;5651.18057881609;5702.572307076985;5743.798967036134;6438.45273151778;6454.93545064548;6476.74093036278;6547.9345206547805;6600.2079750429775;4826.758662066918;4890.877728056827;4902.975485122587;4905.484924082955;4925.75371231437;6719.614536839449;6918.792436226921;6943.826404339881;6949.2008419031445;6963;5037.496250374933;5061.620378471555;5095.261187127846;5110.131277682803;5121.2574176744165;5077.162268225775;5082.440931497532;5131.897362052738;5135.12702840518;5141.845744627667;5721.113227449752;5739.966805974965;5742.397048309951;5751.52684345727;5761.9135712964335;6502.536929190989;6530.379613936669;6664.86670266592;6665.866682666319;6676.566023208476;1687.6202854357916;1729.0576635733555;1753.7457068724964;1755.8499183035133;1767.142935676196;1175.2478413815165;1182.7575347054005;1235.1292338901053;1247.650657815813;1262.0786825617351;5679.630823996427;5720.74256658443;5791.913121303184;5800;5808.5062769665055;6601.70292336846;6618.669066546653;6623.86752264952;6666.666666666647;6680.331966803281;5732.369439361667;5768.451997060272;5806.95474814529;5807.186993820784;5878;3562.1985053363305;3563.429851223792;3575.7496975212007;3600.4959305697225;3642;6481.125048118443;6532.902006469907;6543;6555.311692272338;6560.901586476207;6830.556013859084;6948.652567371611;6976.965115174493;6977;7004.754833580902;6448.677566121675;6484.740610375532;6522.249941256816;6574.967125164344;6583.111279977142;6637.800865974028;6675.833104172434;6739.528233023641;6775.390214880685;6779.762708305186;6571.080048793268;6598.967005164944;6674.232463266787;6682.565633233824;6695.933040669531;6477.4494167996245;6511.73953041873;6546.214454265519;6551.44312733423;6557.409833115043;4928.531789479994;4991.9001619966675;4995.200767877122;5038.798448062036;5057.69653820772;6691.464682825265;6733.326667333227;6743.865122697617;6754.493412994143;6785.423239024738;6526.608403495806;6531.706073226621;6538;6588.176477940257;6611.801366305843;6491.241222480333;6547.377999090078;6556.967215163893;6595.406413422815;6629.403353698191;6284.402981716729;6372.921330348488;6413.326600706859;6445.16212892321;6483.09236706852;6530.216374034956;6560.343965603593;6575.309592492719;6593.318703730518;6607.438367738796;6361.332060133619;6372.840678983062;6393.552451328363;6398.648074355955;6406.871862562816 13:42:07 INFO - PID 3544 | |5;yui.html;892.7857314244583;896.126276880042;923.7505873414178;925.3799954030799;926.8517037274038;16625.334986600537;17212.569685757848;17223.13884305783;17232.655346893087;21850.89074554629;21270.14919403226;21871.12515499382;21890.671639925375;21977.890110549466;22016.88991555044;1032.1742605915276;1060.522764755859;1061.3419679798535;1061.8566493523354;1062.2351906627216;1010.2220092636938;1052.6736711619421;1054.430607471968;1055.1611468882256;1056.234230183115;1091.317926296065;1107.7064577886867;1108.1024370260075;1108.5676586131415;1109.1792073865322;1105.2760441910561;1106.0653747583278;1107.2747350485445;1107.385401102388;1108.1190453589375;807.8990126234221;808.3250485844327;812.1796985045088;813.4793732011517;813.7436707437198;19976.101075451494;20185.697214541793;20260.797392026187;20316;20475;21159.5768084639;21512.247071352584;21625.891870540705;21651.891740541352;21923.342299731034;16475.752863707054;16707.49877503677;16794.32822687103;16838.66322673552;16980.74528882068;3676.8161591920566;3724.8696295629793;3725.9627403725885;3726.5155529781227;3727.8322475488667;132531;133324;133630.3318483411;136980.63019369778;138399;16745.581360465843;17127.14364281781;17203.569910752332;17223.138843057797;17228.827711722974;31582.526262106087;32267.677323226468;32690;32849.83575082157;32906.50640240398;7989.600519973978;8352.83294334122;8762.07998160184;8886.422382545114;9184.357095003286;4178.540360560336;4240.533541310453;4244.129953359554;4252.808623611945;4261.595148460891;5304.283921670525;5317.574594032468;5380.354357477049;5441.782328706887;5456.863578410572;976.1458723616835;976.4092723901937;992.7666998255404;996.9750756231007;999.8450240212778;649.8018104478085;661.454300202335;673.1047706550277;679.9388055075067;686.2005763285816;11745.412729363497;12247.611051137472;12642.30467324306;12971.805422918664;13106.148100373444;658.2331583705026;676.8037269191977;678.0439580191905;689.1041645860362;689.8758223519715;5192.3769147702515;5253.080710875582;5314.070037743457;5369.865753356197;5390.730463476811;102567.4871625637;103397.48301258446;108744.4562777181;108799;109409.45295273473;90846;91475;91873;92638.53680731553;92644.53677731568;85498;87516.6872496913;89293.55353223192;89340.5532972331;90419.54790226006;12507.687307817378;12628;12718.936405317914;12831.615051548468;12952.546660867201;34667.4799877997;35555.644443556266;36078.819605902856;36244.91265262046;38451.03872403212;46808.53191468042;47043.05913881772;47308.2903756437;47457;48099;19030;19426.708599370737;19432.805671943664;19455.90272048631;19514.414567562995;20568.280110196072;20729.58540829145;20733.58532829365;20796.688049678964;20815.791842081384;18534.721979170594;18696.906515467337;18737.250509979447;18758.062096895374;18897.716534251722;18519.166637501614;18940.337088201846;18977.810221897606;19057.809421906157;19098.427047188605;16611.584710382336;16774.664506709552;16882.493525194262;16944.49166525006;17069.91465042667;12332;12542.12205145631;12959.092863499842;13257.66855828612;13861.792073119113;14302.856971430569;14784.186869721838;14814.925925370304;15138.470153544573;15470.381184752934 13:42:07 INFO - PID 3544 | __end_tp_report 13:42:07 INFO - PID 3544 | __start_cc_report 13:42:07 INFO - PID 3544 | _x_x_mozilla_cycle_collect,397 13:42:07 INFO - PID 3544 | __end_cc_report 13:42:07 INFO - PID 3544 | __startTimestamp1501879327872__endTimestamp 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | ------- Summary: start ------- 13:42:07 INFO - PID 3544 | Number of tests: 6 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | [#0] dojo.html Cycles:165 Average:6173.69 Median:6380.33 stddev:716.75 (11.2%) stddev-sans-first:678.89 13:42:07 INFO - PID 3544 | Values: 3161.8 3179.6 3181.2 3204.4 3229.6 6174.1 6271.4 6273.9 6301.3 6339.2 6085.1 6171.4 6191.8 6192.1 6248.4 5680.6 5709.7 5715.3 5729.4 5765.1 5726.1 5736.2 5744.7 5766.4 5852.4 5695.6 5695.9 5755.4 5774.1 5791.6 5490.7 5575.4 5623.6 5646.6 5680.4 5642.5 5691.2 5703.0 5730.6 5732.8 6111.4 6118.1 6185.7 6208.8 6244.4 6512.5 6626.4 6649.2 6652.7 6777.6 6719.6 6722.5 6731.2 6739.6 6746.1 6214.9 6243.4 6257.7 6281.9 6304.2 6686.9 6698.7 6777.5 6806.8 6815.0 6377.6 6380.3 6464.3 6471.6 6515.3 6519.9 6542.9 6551.1 6646.9 6667.8 6727.7 6750.4 6751.7 6777.1 6810.0 6733.9 6816.1 6817.7 6818.3 6828.2 5457.9 5486.1 5545.4 5549.5 5558.7 4630.4 4653.4 4718.2 4720.3 4759.6 5797.5 5904.1 5928.3 5928.9 5930.1 6767.1 6785.5 6791.7 6808.1 6905.3 5777.0 5837.1 5844.3 5927.9 5931.7 5935.3 5938.4 5952.7 5999.0 6025.2 6510.9 6525.6 6541.0 6548.5 6572.3 6634.3 6749.6 6752.0 6801.7 6829.7 6408.4 6504.9 6506.9 6593.3 6595.2 6532.6 6564.2 6576.8 6581.9 6591.4 6631.8 6707.0 6715.4 6740.5 6820.8 6547.5 6590.1 6603.2 6611.6 6634.9 6527.7 6531.8 6618.7 6621.0 6645.5 6330.2 6447.9 6459.0 6557.2 6558.8 6471.9 6543.8 6572.6 6597.3 6607.0 6193.3 6316.8 6340.6 6360.0 6377.0 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | [#1] ext.html Cycles:180 Average:36132.18 Median:34397.81 stddev:53174.13 (154.6%) stddev-sans-first:53257.29 13:42:07 INFO - PID 3544 | Values: 846.8 852.9 877.7 905.8 907.4 42247.0 42907.0 42954.0 43121.8 43297.8 38798.2 39347.2 39380.6 39404.4 39413.6 7069.4 7202.5 7204.7 7208.5 7210.0 7057.2 7117.3 7151.5 7158.4 7160.0 7120.3 7154.7 7156.7 7161.1 7165.9 7001.9 7027.0 7041.8 7051.0 7101.1 6478.4 6490.3 6508.8 6548.0 6570.4 34201.0 34310.3 34517.0 34520.5 34520.5 3363.8 3364.7 3401.2 3403.2 3408.6 26760.0 26800.9 26814.6 26849.2 26939.9 4444.5 4462.4 4478.6 4506.9 4512.7 186673.0 188173.0 188338.0 188699.0 188957.0 22093.7 22103.8 22146.0 22185.2 22202.8 22577.5 22610.8 22622.8 22662.0 22679.3 13435.3 13672.2 13672.4 13687.2 13702.5 13577.4 13584.5 13587.6 13601.4 13604.6 5858.1 5910.6 5961.3 5963.0 6013.8 2430.3 2441.4 2489.3 2499.8 2513.3 1012.6 1013.3 1014.9 1025.0 1030.6 22975.5 23176.0 23367.6 23368.6 23491.2 1117.3 1123.3 1123.7 1124.6 1126.2 12238.7 12291.4 12334.2 12400.2 12440.3 224024.0 224142.0 224784.0 224997.0 225198.0 53138.0 53194.5 53969.5 57823.0 57935.4 1473.6 1488.3 1499.3 1505.0 1505.4 27218.6 27326.5 27566.9 27890.7 28151.6 51576.7 51736.7 51738.0 51795.7 51870.5 196740.0 197374.0 197628.0 198013.0 198388.0 34637.7 34683.0 34684.8 34761.8 35028.6 44055.0 46930.3 48772.3 49024.5 49389.8 34093.3 34545.7 34811.5 35305.3 35759.0 34302.5 34493.0 34581.0 34581.7 35453.5 37585.8 37902.6 38039.0 38047.4 38068.4 33814.2 33982.5 34485.3 34589.8 34611.0 24422.4 24576.5 24619.5 24806.6 24970.5 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | [#2] jquery.html Cycles:180 Average:36615.90 Median:22769.83 stddev:89110.50 (391.4%) stddev-sans-first:89319.41 13:42:07 INFO - PID 3544 | Values: 582.0 591.6 593.1 605.8 612.0 22563.7 22976.0 23497.0 23499.3 23612.2 26301.2 26811.9 26937.9 26983.9 26996.0 6514.3 6673.8 6680.1 6687.9 6695.7 6186.6 6547.9 6623.2 6630.4 6654.0 6543.0 6544.2 6549.8 6550.4 6563.5 6496.8 6520.4 6525.6 6529.7 6531.9 5980.1 6002.9 6012.9 6018.4 6041.4 27250.5 30175.8 30771.5 30965.7 31268.0 1940.1 1976.4 1984.7 1987.8 1987.9 19737.8 20201.1 20211.5 20237.7 20248.0 2325.5 2389.6 2398.1 2424.6 2444.7 134142.0 136112.3 136535.0 137736.0 140260.0 14764.4 14874.4 15498.0 15507.5 15638.2 24053.0 24104.0 24190.8 24256.8 24306.6 10566.3 10722.7 10852.9 10898.9 10918.9 10037.6 10121.7 10151.9 10189.1 10260.2 8935.0 9000.8 9103.6 9207.4 9429.8 2777.8 2790.0 2813.9 2824.8 2870.9 960.5 969.2 979.2 982.6 989.5 19827.8 19921.9 19963.2 20277.9 20482.3 1044.7 1047.3 1056.6 1061.1 1069.8 11242.2 11534.1 13266.4 14087.4 14310.0 511144.0 514547.0 539581.0 540972.0 551144.0 116868.4 122309.4 123675.4 124353.4 124705.4 1246.2 1269.9 1297.9 1306.5 1308.1 21211.4 21342.7 21347.9 21395.6 21466.4 56574.2 57116.7 57836.4 58018.7 59491.1 72189.0 72513.0 72834.0 73053.6 74890.0 12683.7 13185.8 14589.6 15032.5 15034.6 23011.3 23991.5 24027.5 24351.6 24511.1 18993.0 19187.3 19222.2 19301.8 19325.0 16868.2 17119.3 17321.7 17809.0 18219.3 19435.6 20115.3 20147.1 20198.5 20233.0 15031.1 15155.4 15271.3 15300.5 15351.2 18236.2 19041.1 19120.8 19248.5 19258.3 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | [#3] mootools.html Cycles:180 Average:8577.87 Median:2336.25 stddev:5881.20 (251.7%) stddev-sans-first:5872.77 13:42:07 INFO - PID 3544 | Values: 1371.3 1393.9 1439.7 1445.0 1447.4 13380.7 13531.8 13850.3 13878.4 13905.4 14170.6 14528.1 14536.0 14541.6 14564.1 2391.8 2440.7 2446.0 2453.4 2453.7 2321.5 2451.2 2506.6 2508.3 2514.9 2394.3 2426.6 2427.2 2427.2 2428.0 2372.3 2374.4 2411.3 2423.6 2424.7 2312.5 2324.3 2335.3 2337.2 2340.5 13393.9 13738.5 13770.2 13772.4 13784.3 6771.7 6954.9 6984.9 6995.0 7007.6 4727.2 4896.9 4916.0 5024.2 5035.3 1913.7 1914.5 1916.6 1974.2 1974.9 22591.3 22604.1 22777.0 22794.0 22811.3 6404.6 6580.6 6617.8 6644.3 6652.6 14876.8 15005.3 15021.4 15034.2 15048.4 7073.1 7126.9 7373.3 7608.5 7617.5 6681.9 6769.9 6790.0 6926.3 6980.9 4467.4 4569.9 4728.6 4821.7 4884.9 1261.6 1276.2 1297.2 1305.1 1322.9 899.7 918.6 920.3 927.5 935.9 8116.4 8228.8 8237.2 8295.5 8297.8 979.4 990.5 998.2 1005.5 1016.5 4550.8 5525.8 5564.6 5657.5 5854.3 18259.3 18832.4 19207.8 19219.9 19238.7 18788.2 18952.7 19096.1 19098.0 19107.6 10406.5 10692.9 11077.8 11145.8 11203.2 7988.6 8247.3 8500.2 8535.8 8543.4 16388.3 16802.6 16898.9 17107.7 17147.0 17526.6 17679.0 17751.4 17763.3 17865.6 10640.4 10988.6 11083.7 11418.0 11420.2 11449.3 11848.0 12049.3 12243.0 12492.9 10173.7 10608.6 10659.9 10675.8 10779.2 10091.1 10197.7 10643.1 10774.7 10904.7 9012.5 9204.0 9229.2 9248.9 9253.7 7146.5 7155.7 7174.4 7191.2 7258.5 7097.1 7117.2 7241.6 7249.1 7254.1 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | [#4] prototype.html Cycles:180 Average:5505.69 Median:5969.25 stddev:1545.52 (25.9%) stddev-sans-first:1503.53 13:42:07 INFO - PID 3544 | Values: 502.1 508.3 532.3 534.3 534.8 6084.9 6149.0 6176.2 6203.9 6249.3 5872.5 5938.8 6015.5 6043.6 6069.8 4914.8 4925.5 4959.3 4972.9 4976.5 4906.8 4936.5 4953.9 4987.4 5011.1 4791.3 4850.7 4894.3 4935.6 4945.9 4945.4 4966.6 4967.7 4969.6 4970.6 4385.1 4435.9 4443.6 4466.4 4484.7 5875.9 5919.0 5933.9 5942.8 5995.7 5620.7 5647.2 5651.2 5702.6 5743.8 6438.5 6454.9 6476.7 6547.9 6600.2 4826.8 4890.9 4903.0 4905.5 4925.8 6719.6 6918.8 6943.8 6949.2 6963.0 5037.5 5061.6 5095.3 5110.1 5121.3 5077.2 5082.4 5131.9 5135.1 5141.8 5721.1 5740.0 5742.4 5751.5 5761.9 6502.5 6530.4 6664.9 6665.9 6676.6 1687.6 1729.1 1753.7 1755.8 1767.1 1175.2 1182.8 1235.1 1247.7 1262.1 5679.6 5720.7 5791.9 5800.0 5808.5 6601.7 6618.7 6623.9 6666.7 6680.3 5732.4 5768.5 5807.0 5807.2 5878.0 3562.2 3563.4 3575.7 3600.5 3642.0 6481.1 6532.9 6543.0 6555.3 6560.9 6830.6 6948.7 6977.0 6977.0 7004.8 6448.7 6484.7 6522.2 6575.0 6583.1 6637.8 6675.8 6739.5 6775.4 6779.8 6571.1 6599.0 6674.2 6682.6 6695.9 6477.4 6511.7 6546.2 6551.4 6557.4 4928.5 4991.9 4995.2 5038.8 5057.7 6691.5 6733.3 6743.9 6754.5 6785.4 6526.6 6531.7 6538.0 6588.2 6611.8 6491.2 6547.4 6557.0 6595.4 6629.4 6284.4 6372.9 6413.3 6445.2 6483.1 6530.2 6560.3 6575.3 6593.3 6607.4 6361.3 6372.8 6393.6 6398.6 6406.9 13:42:07 INFO - PID 3544 | 13:42:07 INFO - PID 3544 | [#5] yui.html Cycles:180 Average:23244.27 Median:20731.59 stddev:31687.69 (152.8%) stddev-sans-first:31732.13 13:42:07 INFO - PID 3544 | Values: 892.8 896.1 923.8 925.4 926.9 16625.3 17212.6 17223.1 17232.7 21850.9 21270.1 21871.1 21890.7 21977.9 22016.9 1032.2 1060.5 1061.3 1061.9 1062.2 1010.2 1052.7 1054.4 1055.2 1056.2 1091.3 1107.7 1108.1 1108.6 1109.2 1105.3 1106.1 1107.3 1107.4 1108.1 807.9 808.3 812.2 813.5 813.7 19976.1 20185.7 20260.8 20316.0 20475.0 21159.6 21512.2 21625.9 21651.9 21923.3 16475.8 16707.5 16794.3 16838.7 16980.7 3676.8 3724.9 3726.0 3726.5 3727.8 132531.0 133324.0 133630.3 136980.6 138399.0 16745.6 17127.1 17203.6 17223.1 17228.8 31582.5 32267.7 32690.0 32849.8 32906.5 7989.6 8352.8 8762.1 8886.4 9184.4 4178.5 4240.5 4244.1 4252.8 4261.6 5304.3 5317.6 5380.4 5441.8 5456.9 976.1 976.4 992.8 997.0 999.8 649.8 661.5 673.1 679.9 686.2 11745.4 12247.6 12642.3 12971.8 13106.1 658.2 676.8 678.0 689.1 689.9 5192.4 5253.1 5314.1 5369.9 5390.7 102567.5 103397.5 108744.5 108799.0 109409.5 90846.0 91475.0 91873.0 92638.5 92644.5 85498.0 87516.7 89293.6 89340.6 90419.5 12507.7 12628.0 12718.9 12831.6 12952.5 34667.5 35555.6 36078.8 36244.9 38451.0 46808.5 47043.1 47308.3 47457.0 48099.0 19030.0 19426.7 19432.8 19455.9 19514.4 20568.3 20729.6 20733.6 20796.7 20815.8 18534.7 18696.9 18737.3 18758.1 18897.7 18519.2 18940.3 18977.8 19057.8 19098.4 16611.6 16774.7 16882.5 16944.5 17069.9 12332.0 12542.1 12959.1 13257.7 13861.8 14302.9 14784.2 14814.9 15138.5 15470.4 13:42:07 INFO - PID 3544 | -------- Summary: end -------- 13:42:07 INFO - PID 3544 | 13:42:08 INFO - TEST-INFO | 3544: exit 0 13:42:08 INFO - TEST-OK | dromaeo_css | took 1113355ms 13:42:08 INFO - TEST-START | kraken 13:42:08 INFO - Initialising browser for kraken test... 13:42:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47066/getInfo.html -profile /tmp/tmpELUMmv/profile 13:42:08 INFO - TEST-INFO | started process 3907 (/builds/slave/test/build/application/firefox/firefox http://localhost:47066/getInfo.html) 13:42:13 INFO - TEST-INFO | 3907: exit 0 13:42:14 INFO - Browser initialized. 13:42:14 INFO - Running cycle 1/1 for kraken test... 13:42:14 INFO - TEST-INFO | started process 4113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpELUMmv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:14 INFO - PID 4113 | 13:42:14 INFO - PID 4113 | (/builds/slave/test/build/application/firefox/firefox:4161): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:42:14 INFO - PID 4113 | 13:42:25 INFO - PID 4113 | RSS: Main: 171245568 13:42:25 INFO - PID 4113 | 13:42:27 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47066/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:28 INFO - PID 4113 | RSS: Main: 176308224 13:42:28 INFO - PID 4113 | 13:42:31 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47066/tests/kraken/driver.html?testName=audio-dft) 13:42:32 INFO - PID 4113 | RSS: Main: 177635328 13:42:32 INFO - PID 4113 | 13:42:35 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47066/tests/kraken/driver.html?testName=audio-fft) 13:42:35 INFO - PID 4113 | RSS: Main: 171667456 13:42:35 INFO - PID 4113 | 13:42:37 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47066/tests/kraken/driver.html?testName=audio-oscillator) 13:42:38 INFO - PID 4113 | RSS: Main: 172195840 13:42:38 INFO - PID 4113 | 13:42:40 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:42:41 INFO - PID 4113 | RSS: Main: 172220416 13:42:41 INFO - PID 4113 | 13:42:44 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47066/tests/kraken/driver.html?testName=imaging-darkroom) 13:42:44 INFO - PID 4113 | RSS: Main: 174985216 13:42:44 INFO - PID 4113 | 13:42:48 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47066/tests/kraken/driver.html?testName=imaging-desaturate) 13:42:49 INFO - PID 4113 | RSS: Main: 175390720 13:42:49 INFO - PID 4113 | 13:42:51 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47066/tests/kraken/driver.html?testName=json-parse-financial) 13:42:52 INFO - PID 4113 | RSS: Main: 175841280 13:42:52 INFO - PID 4113 | 13:42:54 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:42:54 INFO - PID 4113 | RSS: Main: 175448064 13:42:54 INFO - PID 4113 | 13:42:56 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:42:57 INFO - PID 4113 | RSS: Main: 175620096 13:42:57 INFO - PID 4113 | 13:42:59 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:42:59 INFO - PID 4113 | RSS: Main: 172482560 13:42:59 INFO - PID 4113 | 13:43:02 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:03 INFO - PID 4113 | RSS: Main: 173338624 13:43:03 INFO - PID 4113 | 13:43:06 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:07 INFO - PID 4113 | RSS: Main: 172818432 13:43:07 INFO - PID 4113 | 13:43:08 INFO - PID 4113 | Cycle 1(1): loaded http://localhost:47066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47066/tests/kraken/driver.html?testName=ai-astar) 13:43:09 INFO - PID 4113 | RSS: Main: 174276608 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | __start_tp_report 13:43:09 INFO - PID 4113 | _x_x_mozilla_page_load 13:43:09 INFO - PID 4113 | _x_x_mozilla_page_load_details 13:43:09 INFO - PID 4113 | |i|pagename|runs| 13:43:09 INFO - PID 4113 | |0;ai-astar;97;110;99;107;108;108;113;102;107;108 13:43:09 INFO - PID 4113 | |1;audio-beat-detection;145;122;152;179;120;152;143;118;173;118 13:43:09 INFO - PID 4113 | |2;audio-dft;164;163;163;163;163;161;162;168;170;161 13:43:09 INFO - PID 4113 | |3;audio-fft;74;75;75;167;85;75;73;88;105;74 13:43:09 INFO - PID 4113 | |4;audio-oscillator;79;79;131;79;79;78;136;78;78;122 13:43:09 INFO - PID 4113 | |5;imaging-gaussian-blur;114;115;115;114;115;114;114;114;115;114 13:43:09 INFO - PID 4113 | |6;imaging-darkroom;151;151;151;150;151;152;150;150;151;152 13:43:09 INFO - PID 4113 | |7;imaging-desaturate;94;94;94;94;94;94;94;93;94;94 13:43:09 INFO - PID 4113 | |8;json-parse-financial;56;55;54;54;60;55;56;55;55;55 13:43:09 INFO - PID 4113 | |9;json-stringify-tinderbox;53;54;53;53;54;54;53;53;53;54 13:43:09 INFO - PID 4113 | |10;stanford-crypto-aes;78;77;76;78;79;92;83;97;89;78 13:43:09 INFO - PID 4113 | |11;stanford-crypto-ccm;131;128;137;135;124;134;130;132;123;160 13:43:09 INFO - PID 4113 | |12;stanford-crypto-pbkdf2;171;189;172;170;187;172;174;171;174;182 13:43:09 INFO - PID 4113 | |13;stanford-crypto-sha256-iterative;66;68;67;65;64;66;64;66;66;78 13:43:09 INFO - PID 4113 | __end_tp_report 13:43:09 INFO - PID 4113 | __start_cc_report 13:43:09 INFO - PID 4113 | _x_x_mozilla_cycle_collect,911 13:43:09 INFO - PID 4113 | __end_cc_report 13:43:09 INFO - PID 4113 | __startTimestamp1501879389078__endTimestamp 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | ------- Summary: start ------- 13:43:09 INFO - PID 4113 | Number of tests: 14 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#0] ai-astar Cycles:10 Average:105.90 Median:109.00 stddev:5.00 (4.6%) stddev-sans-first:4.14 13:43:09 INFO - PID 4113 | Values: 97.0 110.0 99.0 107.0 108.0 108.0 113.0 102.0 107.0 108.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:22.55 (15.2%) stddev-sans-first:23.89 13:43:09 INFO - PID 4113 | Values: 145.0 122.0 152.0 179.0 120.0 152.0 143.0 118.0 173.0 118.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.94 (1.8%) stddev-sans-first:3.11 13:43:09 INFO - PID 4113 | Values: 164.0 163.0 163.0 163.0 163.0 161.0 162.0 168.0 170.0 161.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.00 stddev:29.16 (38.9%) stddev-sans-first:30.41 13:43:09 INFO - PID 4113 | Values: 74.0 75.0 75.0 167.0 85.0 75.0 73.0 88.0 105.0 74.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:78.50 stddev:24.91 (31.7%) stddev-sans-first:25.83 13:43:09 INFO - PID 4113 | Values: 79.0 79.0 131.0 79.0 79.0 78.0 136.0 78.0 78.0 122.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:43:09 INFO - PID 4113 | Values: 114.0 115.0 115.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:43:09 INFO - PID 4113 | Values: 151.0 151.0 151.0 150.0 151.0 152.0 150.0 150.0 151.0 152.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:43:09 INFO - PID 4113 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.72 (3.1%) stddev-sans-first:1.81 13:43:09 INFO - PID 4113 | Values: 56.0 55.0 54.0 54.0 60.0 55.0 56.0 55.0 55.0 55.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 13:43:09 INFO - PID 4113 | Values: 53.0 54.0 53.0 53.0 54.0 54.0 53.0 53.0 53.0 54.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:81.00 stddev:7.36 (9.1%) stddev-sans-first:7.61 13:43:09 INFO - PID 4113 | Values: 78.0 77.0 76.0 78.0 79.0 92.0 83.0 97.0 89.0 78.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:133.00 stddev:10.37 (7.8%) stddev-sans-first:10.97 13:43:09 INFO - PID 4113 | Values: 131.0 128.0 137.0 135.0 124.0 134.0 130.0 132.0 123.0 160.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:174.00 stddev:7.08 (4.1%) stddev-sans-first:7.26 13:43:09 INFO - PID 4113 | Values: 171.0 189.0 172.0 170.0 187.0 172.0 174.0 171.0 174.0 182.0 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.00 stddev:4.06 (6.1%) stddev-sans-first:4.28 13:43:09 INFO - PID 4113 | Values: 66.0 68.0 67.0 65.0 64.0 66.0 64.0 66.0 66.0 78.0 13:43:09 INFO - PID 4113 | -------- Summary: end -------- 13:43:09 INFO - PID 4113 | 13:43:09 INFO - PID 4113 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:43:09 INFO - TEST-INFO | 4113: exit 0 13:43:09 INFO - TEST-OK | kraken | took 61232ms 13:43:09 INFO - SUITE-END | took 1174s 13:43:10 INFO - Completed test suite (00:19:35) 13:43:10 INFO - javascript benchmark 13:43:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8362.933322357247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.7944833585802, 3179.618445786505, 3181.1569933967494, 3204.375146846363, 3229.6124465064195, 6174.10475481055, 6271.4042165994215, 6273.874522509553, 6301.2753533343675, 6339.175907132078, 6085.148079268894, 6171.352008039158, 6191.814245572628, 6192.102145188945, 6248.37516248375, 5680.573956953234, 5709.685967271798, 5715.257016587838, 5729.39841316662, 5765.1352297155345, 5726.055200891848, 5736.196932429442, 5744.712764361786, 5766.365699773021, 5852.4440178183, 5695.572832037593, 5695.857603559903, 5755.366909639936, 5774.1050137228585, 5791.623544469596, 5490.725463726838, 5575.358833734132, 5623.606347555673, 5646.632968857011, 5680.375158732536, 5642.520385767215, 5691.174779656968, 5703.0, 5730.6275092119295, 5732.799352022701, 6111.35830737775, 6118.051701986199, 6185.690715464209, 6208.751649933997, 6244.3755624437645, 6512.544121911468, 6626.370494802986, 6649.235337936151, 6652.667366631697, 6777.559458635223, 6719.563228390139, 6722.495812814059, 6731.225909020476, 6739.561928474683, 6746.055552222692, 6214.875702485971, 6243.438090571825, 6257.7184026718905, 6281.874362512815, 6304.211973503312, 6686.866262674816, 6698.698558564876, 6777.49168812341, 6806.829829254309, 6815.045893574904, 6377.585456945284, 6380.330065343072, 6464.25661048976, 6471.579347342407, 6515.250746164157, 6519.942239705261, 6542.869142617121, 6551.050097735897, 6646.936490161647, 6667.766628167991, 6727.730890764413, 6750.426213771786, 6751.696173672197, 6777.1189745332795, 6810.046593476917, 6733.8653226935185, 6816.07982922309, 6817.659117044128, 6818.318168183142, 6828.2147553031045, 5457.945420545823, 5486.1222204447895, 5545.445455454503, 5549.472800083986, 5558.666480011131, 4630.398048253773, 4653.395058642423, 4718.197906355859, 4720.33915251865, 4759.571638552547, 5797.536197104221, 5904.0553511437965, 5928.318243402064, 5928.881422371528, 5930.080837470199, 6767.052612634235, 6785.525013249124, 6791.728330866808, 6808.11494505721, 6905.343992320722, 5777.0467872801355, 5837.09525023622, 5844.298684157929, 5927.881442371128, 5931.673757943268, 5935.347111817697, 5938.406159384027, 5952.7023648817385, 5999.040153575407, 6025.15647809307, 6510.934890651128, 6525.575837570543, 6540.967295163494, 6548.508861835381, 6572.277049524549, 6634.336566343327, 6749.595024298558, 6752.0, 6801.727930882709, 6829.736498747748, 6408.391202835724, 6504.869902601827, 6506.902396464152, 6593.274739778524, 6595.241547221939, 6532.640704761094, 6564.245111812203, 6576.76981305652, 6581.868362632817, 6591.373819487141, 6631.767888123893, 6707.027481015323, 6715.3620406061345, 6740.460763139035, 6820.795376138723, 6547.508936829661, 6590.110335104891, 6603.2406273277265, 6611.570247934062, 6634.933650663432, 6527.738890444519, 6531.771388001397, 6618.7352505899225, 6621.0, 6645.534812563267, 6330.208723909512, 6447.9032814508755, 6459.0, 6557.180352455943, 6558.8360290991195, 6471.870562588816, 6543.836404089936, 6572.605643661395, 6597.2742998271115, 6606.966965165144, 6193.287771906288, 6316.778912738032, 6340.619562826245, 6360.045993101072, 6377.0], "value": 6120.746859294901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.7756044648165, 852.9317654587634, 877.736678996301, 905.836949349117, 907.3512438606396, 42247.0, 42907.0, 42954.0, 43121.784391078, 43297.78351108244, 38798.22403551927, 39347.21305573887, 39380.606193938125, 39404.40893386595, 39413.60586394135, 7069.363757261845, 7202.4958252922315, 7204.747833825817, 7208.49540532163, 7210.0, 7057.223705392403, 7117.2882711728935, 7151.535150215245, 7158.427325813923, 7159.964200178992, 7120.323569260938, 7154.713811447536, 7156.749513767019, 7161.069061022086, 7165.9283407165785, 7001.929980700179, 7027.016217729548, 7041.823954401129, 7051.0, 7101.11236095488, 6478.416942475153, 6490.253620833618, 6508.772192973223, 6547.967260163717, 6570.375814297634, 34201.0, 34310.31379372399, 34517.0, 34520.48219276713, 34520.48219276713, 3363.814990175539, 3364.7308215342714, 3401.183715908189, 3403.1662242750435, 3408.625051244361, 26760.0, 26800.86599567009, 26814.5977810333, 26849.194524164308, 26939.865300673566, 4444.466664000308, 4462.419885414908, 4478.596926276651, 4506.8873278167985, 4512.661550383735, 186673.0, 188173.0, 188338.0, 188699.0, 188957.0, 22093.668594971088, 22103.778962210174, 22146.0, 22185.223517176822, 22202.777972220396, 22577.548449030928, 22610.773892261197, 22622.773772262397, 22662.0, 22679.319620411414, 13435.328233588281, 13672.248026358646, 13672.384742686603, 13687.178769273876, 13702.52041178554, 13577.389017494237, 13584.456621735217, 13587.59237222885, 13601.387937542637, 13604.591862243951, 5858.091995740667, 5910.645361278337, 5961.344252132262, 5962.970185149046, 6013.759449622054, 2430.2709187243754, 2441.4140606254728, 2489.253224032783, 2499.7750202481866, 2513.308840068996, 1012.5899010900597, 1013.2805707947292, 1014.8934361891895, 1024.9692509224735, 1030.5929157982555, 22975.540489190458, 23176.0, 23367.649485257734, 23368.64947025796, 23491.17780877661, 1117.273772048159, 1123.3428444359977, 1123.6572845282103, 1124.6007667277997, 1126.2172789911097, 12238.694032649255, 12291.446884890202, 12334.198277111958, 12400.19398739079, 12440.315782632042, 224024.0, 224142.0, 224784.0, 224997.0, 225198.0, 53138.0, 53194.468055319725, 53969.46030539723, 57823.0, 57935.42064579385, 1473.6389584551853, 1488.263309661746, 1499.3028241867366, 1504.9849501504846, 1505.4279373837871, 27218.5917211238, 27326.45347093087, 27566.862165689847, 27890.72109278881, 28151.57772633371, 51576.74211628918, 51736.74131629318, 51738.0, 51795.74102129465, 51870.48129518657, 196740.0, 197374.0, 197628.0, 198013.0, 198388.0, 34637.65362346344, 34683.0, 34684.82657586797, 34761.82619086889, 35028.64971350254, 44055.0, 46930.29604555866, 48772.26841597308, 49024.50975490342, 49389.75305123451, 34093.31813363769, 34545.654543455246, 34811.47782783311, 35305.293894122486, 35759.0, 34302.48546271858, 34493.0, 34581.0, 34581.654183457846, 35453.46819797757, 37585.81207093947, 37902.62097378991, 38039.0, 38047.42928856014, 38068.42897356486, 33814.15464613306, 33982.49026264559, 34485.310293794486, 34589.82705086459, 34611.0, 24422.389440264134, 24576.511923450842, 24619.507609847344, 24806.627900581865, 24970.500589988464], "value": 15645.941384367565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.9534437245021, 591.624318557716, 593.1073734030284, 605.791002104274, 611.9755209791608, 22563.661545076815, 22976.0, 23497.0, 23499.29502114937, 23612.173573924916, 26301.210963671074, 26811.865940670268, 26937.86531067342, 26983.865080674568, 26996.0, 6514.250861150981, 6673.833154171136, 6680.131582894217, 6687.866242675143, 6695.698693558801, 6186.628802271855, 6547.9017814732815, 6623.205215374138, 6630.3701148391065, 6654.0, 6542.967285163568, 6544.247411547685, 6549.836254093638, 6550.443212326934, 6563.507736919726, 6496.837579060514, 6520.380563846427, 6525.575837570566, 6529.706163222642, 6531.93468065318, 5980.073088671263, 6002.939970600281, 6012.879742405171, 6018.368071352533, 6041.365656606081, 27250.45499090007, 30175.849120754476, 30771.538426923613, 30965.690343096507, 31268.0, 1940.0978544976654, 1976.416956997689, 1984.7320611717378, 1987.8012198780007, 1987.8906660133687, 19737.80262197374, 20201.0909509071, 20211.494712632153, 20237.696434553494, 20248.0, 2325.476767727248, 2389.617661174204, 2398.1126983016397, 2424.6120620700603, 2444.6821913151352, 134142.0, 136112.31943840216, 136535.0, 137736.0, 140260.0, 14764.409423622934, 14874.405023799143, 15498.0, 15507.534773956799, 15638.2180890955, 24053.0, 24104.0, 24190.758092419204, 24256.75743242545, 24306.635400469007, 10566.260361774603, 10722.678319650424, 10852.891471085188, 10898.891011089947, 10918.890811091946, 10037.598496060076, 10121.69634910954, 10151.898481015096, 10189.133923616428, 10260.179185665129, 8935.034292455779, 9000.774980625405, 9103.590338434786, 9207.355485115977, 9429.811403771886, 2777.847218402967, 2789.986050069737, 2813.887444502197, 2824.8163869348427, 2870.885164593393, 960.5485421851719, 969.1665167955553, 979.2215188924822, 982.5873133284038, 989.5151375825793, 19827.801721982883, 19921.900390497955, 19963.20147194125, 20277.89861050715, 20482.283120090724, 1044.6604853422668, 1047.2930771729204, 1056.6248981611418, 1061.0927656853435, 1069.8341757027674, 11242.213045086928, 11534.077273818075, 13266.40301186449, 14087.436502539784, 14309.9983001191, 511144.0, 514547.0, 539581.0, 540972.0, 551144.0, 116868.41565792117, 122309.38845305717, 123675.3816230913, 124353.37823310826, 124705.37647311705, 1246.2148846227, 1269.9492020319083, 1297.8702129787134, 1306.5296493262417, 1308.1431662261234, 21211.363659090253, 21342.679859802425, 21347.893260533598, 21395.572088558452, 21466.356009319745, 56574.151387728394, 57116.714416427654, 57836.42163578478, 58018.709906450196, 59491.107633384665, 72189.0, 72513.0, 72834.0, 73053.634731826, 74890.0, 12683.682907927376, 13185.802212967004, 14589.635259118608, 15032.549023529311, 15034.624134396727, 23011.309660710205, 23991.52016959686, 24027.51944961056, 24351.634725479485, 24511.142110026776, 18993.0, 19187.32844350441, 19222.231110755412, 19301.80698193, 19325.0, 16868.24092915797, 17119.315227390765, 17321.653566928842, 17809.020503872413, 18219.271229150687, 19435.61128777445, 20115.29596464117, 20147.093380798193, 20198.495037624176, 20233.0, 15031.098134111988, 15155.393784248507, 15271.312790924212, 15300.540983770505, 15351.23243837826, 18236.17937192803, 19041.143148558072, 19120.80879191246, 19248.518787029876, 19258.325958591384], "value": 12390.839909761728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.3074897176925, 1393.919712223027, 1439.7120575884826, 1445.0, 1447.3993292783496, 13380.665483362909, 13531.797023044663, 13850.307484625766, 13878.444862205499, 13905.374258158381, 14170.645733856658, 14528.128312301269, 14536.0, 14541.563753087397, 14564.126152430861, 2391.8445301055417, 2440.694913135858, 2446.0460420436043, 2453.386653336666, 2453.6810214672155, 2321.4892723600783, 2451.2278632230878, 2506.5989441689335, 2508.3227528567277, 2514.9119780807673, 2394.2936833634035, 2426.575349313872, 2427.174760581402, 2427.2232885476656, 2427.9635805462844, 2372.252740386781, 2374.382660508263, 2411.3248290478696, 2423.6243382275775, 2424.7090349158125, 2312.4681323295567, 2324.32594547581, 2335.2760644200184, 2337.2170322941834, 2340.461693810433, 13393.866061339359, 13738.519151829638, 13770.24263665498, 13772.449102035907, 13784.310784460737, 6771.695273712695, 6954.930450695479, 6984.930150698478, 6995.0, 7007.649617519103, 4727.22000869856, 4896.902061958776, 4915.950840491585, 5024.221245706921, 5035.320231768701, 1913.7033759767257, 1914.4543805015644, 1916.6358391905494, 1974.2300502803919, 1974.8518861085477, 22591.322260332054, 22604.095836166696, 22777.0, 22794.0, 22811.31566053021, 6404.5837020594445, 6580.63806490638, 6617.834554136185, 6644.302348253461, 6652.567583107082, 14876.776848347283, 15005.324760385809, 15021.399144034116, 15034.248287585577, 15048.398064077313, 7073.115860517435, 7126.857462850714, 7373.262673732691, 7608.505447145918, 7617.5048621839405, 6681.866362672719, 6769.93230067693, 6789.966050169717, 6926.307369263033, 6980.860382792316, 4467.419235499365, 4569.885752856138, 4728.645351598644, 4821.662483626113, 4884.853454396374, 1261.6025951825145, 1276.2215048820212, 1297.1762930539176, 1305.0799186573443, 1322.9404676789568, 899.6671231644202, 918.5820451694597, 920.2821798996794, 927.5408672707053, 935.8830146231721, 8116.35069194463, 8228.753137405887, 8237.176282371835, 8295.502269863828, 8297.751067467985, 979.4466126638426, 990.5195979949718, 998.1565577087349, 1005.527402121002, 1016.5222345497605, 4550.772461376918, 5525.806596769094, 5564.582656300794, 5657.4908258256955, 5854.326752423441, 18259.26962921495, 18832.435026949213, 19207.80792192088, 19219.903900480407, 19238.71141932872, 18788.248470061044, 18952.715709264372, 19096.140673669717, 19098.0, 19107.617847643247, 10406.479676016168, 10692.89307106919, 11077.833832492357, 11145.83281250798, 11203.21577489568, 7988.640511177127, 8247.257746802816, 8500.234978851686, 8535.786605334917, 8543.401961862859, 16388.26252818602, 16802.57993550122, 16898.915505422396, 17107.743383849003, 17147.0, 17526.561835954202, 17679.0, 17751.378701745376, 17763.289468421117, 17865.553361165556, 10640.414777187329, 10988.615398461016, 11083.72290692739, 11418.0, 11420.200585958903, 11449.313041217554, 11848.0, 12049.33728644898, 12243.0, 12492.937535312265, 10173.694789156338, 10608.628697995533, 10659.8934010662, 10675.786484270426, 10779.191560632828, 10091.142252908292, 10197.694069177936, 10643.148548115978, 10774.676759697222, 10904.727381815517, 9012.504312262889, 9204.033576474641, 9229.169374756304, 9248.861267081134, 9253.72238832836, 7146.499745017799, 7155.749548765768, 7174.354308112295, 7191.244919283609, 7258.49190556656, 7097.112860892388, 7117.181524124792, 7241.637918104179, 7249.130104387507, 7254.129504459499], "value": 6232.283788235745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.05864004990656, 508.26301862299675, 532.270789019044, 534.2787237229738, 534.7620308962512, 6084.9391506084985, 6148.969255153724, 6176.166217560628, 6203.875922481548, 6249.281332646747, 5872.471477567018, 5938.7624495020145, 6015.548833837458, 6043.637381757087, 6069.814866648003, 4914.827981020647, 4925.458199598042, 4959.305697202394, 4972.875678108058, 4976.452590215083, 4906.803727850899, 4936.481669424713, 4953.851384458472, 4987.426445958725, 5011.141421105746, 4791.257355109963, 4850.684705494132, 4894.3392641993405, 4935.605151587883, 4945.876353091166, 4945.431275403339, 4966.5778408835295, 4967.7019378837385, 4969.552740253394, 4970.627202959792, 4385.101054283864, 4435.911281774379, 4443.577860103285, 4466.374707540915, 4484.708493947883, 5875.941240587582, 5918.957959503964, 5933.851653708649, 5942.762289508414, 5995.730192141364, 5620.747066382022, 5647.209390685307, 5651.18057881609, 5702.572307076985, 5743.798967036134, 6438.45273151778, 6454.93545064548, 6476.74093036278, 6547.9345206547805, 6600.2079750429775, 4826.758662066918, 4890.877728056827, 4902.975485122587, 4905.484924082955, 4925.75371231437, 6719.614536839449, 6918.792436226921, 6943.826404339881, 6949.2008419031445, 6963.0, 5037.496250374933, 5061.620378471555, 5095.261187127846, 5110.131277682803, 5121.2574176744165, 5077.162268225775, 5082.440931497532, 5131.897362052738, 5135.12702840518, 5141.845744627667, 5721.113227449752, 5739.966805974965, 5742.397048309951, 5751.52684345727, 5761.9135712964335, 6502.536929190989, 6530.379613936669, 6664.86670266592, 6665.866682666319, 6676.566023208476, 1687.6202854357916, 1729.0576635733555, 1753.7457068724964, 1755.8499183035133, 1767.142935676196, 1175.2478413815165, 1182.7575347054005, 1235.1292338901053, 1247.650657815813, 1262.0786825617351, 5679.630823996427, 5720.74256658443, 5791.913121303184, 5800.0, 5808.5062769665055, 6601.70292336846, 6618.669066546653, 6623.86752264952, 6666.666666666647, 6680.331966803281, 5732.369439361667, 5768.451997060272, 5806.95474814529, 5807.186993820784, 5878.0, 3562.1985053363305, 3563.429851223792, 3575.7496975212007, 3600.4959305697225, 3642.0, 6481.125048118443, 6532.902006469907, 6543.0, 6555.311692272338, 6560.901586476207, 6830.556013859084, 6948.652567371611, 6976.965115174493, 6977.0, 7004.754833580902, 6448.677566121675, 6484.740610375532, 6522.249941256816, 6574.967125164344, 6583.111279977142, 6637.800865974028, 6675.833104172434, 6739.528233023641, 6775.390214880685, 6779.762708305186, 6571.080048793268, 6598.967005164944, 6674.232463266787, 6682.565633233824, 6695.933040669531, 6477.4494167996245, 6511.73953041873, 6546.214454265519, 6551.44312733423, 6557.409833115043, 4928.531789479994, 4991.9001619966675, 4995.200767877122, 5038.798448062036, 5057.69653820772, 6691.464682825265, 6733.326667333227, 6743.865122697617, 6754.493412994143, 6785.423239024738, 6526.608403495806, 6531.706073226621, 6538.0, 6588.176477940257, 6611.801366305843, 6491.241222480333, 6547.377999090078, 6556.967215163893, 6595.406413422815, 6629.403353698191, 6284.402981716729, 6372.921330348488, 6413.326600706859, 6445.16212892321, 6483.09236706852, 6530.216374034956, 6560.343965603593, 6575.309592492719, 6593.318703730518, 6607.438367738796, 6361.332060133619, 6372.840678983062, 6393.552451328363, 6398.648074355955, 6406.871862562816], "value": 5052.578505491758, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.7857314244583, 896.126276880042, 923.7505873414178, 925.3799954030799, 926.8517037274038, 16625.334986600537, 17212.569685757848, 17223.13884305783, 17232.655346893087, 21850.89074554629, 21270.14919403226, 21871.12515499382, 21890.671639925375, 21977.890110549466, 22016.88991555044, 1032.1742605915276, 1060.522764755859, 1061.3419679798535, 1061.8566493523354, 1062.2351906627216, 1010.2220092636938, 1052.6736711619421, 1054.430607471968, 1055.1611468882256, 1056.234230183115, 1091.317926296065, 1107.7064577886867, 1108.1024370260075, 1108.5676586131415, 1109.1792073865322, 1105.2760441910561, 1106.0653747583278, 1107.2747350485445, 1107.385401102388, 1108.1190453589375, 807.8990126234221, 808.3250485844327, 812.1796985045088, 813.4793732011517, 813.7436707437198, 19976.101075451494, 20185.697214541793, 20260.797392026187, 20316.0, 20475.0, 21159.5768084639, 21512.247071352584, 21625.891870540705, 21651.891740541352, 21923.342299731034, 16475.752863707054, 16707.49877503677, 16794.32822687103, 16838.66322673552, 16980.74528882068, 3676.8161591920566, 3724.8696295629793, 3725.9627403725885, 3726.5155529781227, 3727.8322475488667, 132531.0, 133324.0, 133630.3318483411, 136980.63019369778, 138399.0, 16745.581360465843, 17127.14364281781, 17203.569910752332, 17223.138843057797, 17228.827711722974, 31582.526262106087, 32267.677323226468, 32690.0, 32849.83575082157, 32906.50640240398, 7989.600519973978, 8352.83294334122, 8762.07998160184, 8886.422382545114, 9184.357095003286, 4178.540360560336, 4240.533541310453, 4244.129953359554, 4252.808623611945, 4261.595148460891, 5304.283921670525, 5317.574594032468, 5380.354357477049, 5441.782328706887, 5456.863578410572, 976.1458723616835, 976.4092723901937, 992.7666998255404, 996.9750756231007, 999.8450240212778, 649.8018104478085, 661.454300202335, 673.1047706550277, 679.9388055075067, 686.2005763285816, 11745.412729363497, 12247.611051137472, 12642.30467324306, 12971.805422918664, 13106.148100373444, 658.2331583705026, 676.8037269191977, 678.0439580191905, 689.1041645860362, 689.8758223519715, 5192.3769147702515, 5253.080710875582, 5314.070037743457, 5369.865753356197, 5390.730463476811, 102567.4871625637, 103397.48301258446, 108744.4562777181, 108799.0, 109409.45295273473, 90846.0, 91475.0, 91873.0, 92638.53680731553, 92644.53677731568, 85498.0, 87516.6872496913, 89293.55353223192, 89340.5532972331, 90419.54790226006, 12507.687307817378, 12628.0, 12718.936405317914, 12831.615051548468, 12952.546660867201, 34667.4799877997, 35555.644443556266, 36078.819605902856, 36244.91265262046, 38451.03872403212, 46808.53191468042, 47043.05913881772, 47308.2903756437, 47457.0, 48099.0, 19030.0, 19426.708599370737, 19432.805671943664, 19455.90272048631, 19514.414567562995, 20568.280110196072, 20729.58540829145, 20733.58532829365, 20796.688049678964, 20815.791842081384, 18534.721979170594, 18696.906515467337, 18737.250509979447, 18758.062096895374, 18897.716534251722, 18519.166637501614, 18940.337088201846, 18977.810221897606, 19057.809421906157, 19098.427047188605, 16611.584710382336, 16774.664506709552, 16882.493525194262, 16944.49166525006, 17069.91465042667, 12332.0, 12542.12205145631, 12959.092863499842, 13257.66855828612, 13861.792073119113, 14302.856971430569, 14784.186869721838, 14814.925925370304, 15138.470153544573, 15470.381184752934], "value": 9155.022226200368, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 110.0, 99.0, 107.0, 108.0, 108.0, 113.0, 102.0, 107.0, 108.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 152.0, 179.0, 120.0, 152.0, 143.0, 118.0, 173.0, 118.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 161.0, 162.0, 168.0, 170.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 167.0, 85.0, 75.0, 73.0, 88.0, 105.0, 74.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 131.0, 79.0, 79.0, 78.0, 136.0, 78.0, 78.0, 122.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 151.0, 152.0, 150.0, 150.0, 151.0, 152.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 60.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 78.0, 79.0, 92.0, 83.0, 97.0, 89.0, 78.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 137.0, 135.0, 124.0, 134.0, 130.0, 132.0, 123.0, 160.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 189.0, 172.0, 170.0, 187.0, 172.0, 174.0, 171.0, 174.0, 182.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 65.0, 64.0, 66.0, 64.0, 66.0, 66.0, 78.0], "value": 67.0, "unit": "score"}]}]} 13:43:10 INFO - Return code: 0 13:43:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:43:10 INFO - # TBPL SUCCESS # 13:43:10 INFO - Running post-action listener: _package_coverage_data 13:43:10 INFO - Running post-action listener: _resource_record_post_action 13:43:10 INFO - [mozharness: 2017-08-04 20:43:10.355026Z] Finished run-tests step (success) 13:43:10 INFO - Running post-run listener: _resource_record_post_run 13:43:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 5894144; Write bytes: 443531264; Read time: 2452; Write time: 335544 13:43:10 INFO - TinderboxPrint: CPU usage
13.1% 13:43:10 INFO - TinderboxPrint: I/O read bytes / time
5,894,144 / 2,452 13:43:10 INFO - TinderboxPrint: I/O write bytes / time
443,531,264 / 335,544 13:43:10 INFO - TinderboxPrint: CPU idle
8,260.8 (86.8%) 13:43:10 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 13:43:10 INFO - TinderboxPrint: Swap in / out
0 / 0 13:43:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119762944; Read time: 0; Write time: 86548 13:43:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:43:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 3530752; Write bytes: 323768320; Read time: 1868; Write time: 248996 13:43:10 INFO - Running post-run listener: _upload_blobber_files 13:43:10 INFO - Blob upload gear active. 13:43:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:10 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 13:43:10 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'] 13:43:10 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 13:43:11 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:43:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:12 INFO - (blobuploader) - INFO - Done attempting. 13:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:13 INFO - (blobuploader) - INFO - Done attempting. 13:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:13 INFO - (blobuploader) - INFO - Done attempting. 13:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:17 INFO - (blobuploader) - INFO - Done attempting. 13:43:17 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:17 INFO - Return code: 0 13:43:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8301cbdba9a186cd80594cf5fac2094f5d4c79c6821271eea1652fc90b8b4b749a1b7b1d753e50d25e9f57aa58bfa7a393598dac55123f99242d3f7f07b63afd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f293ab289a385d1ce2d07fd39b6d4032c7c910e44be1dae2c5ea70be1c08c43f699d3eefd252bd36b1eb63abb64f58c94474edf6478d7f9c17e9dd1a1f72118", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69d2c510377cf660b03e2baae6391d2b70210604f2e3658a9250a46e19957a244713a80143c2fcae23e376fa746715cbe34f1cdcf822a9d57a3b01dd9a2aaf8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ba7e2bed1030c2348eedb0793f652a42002cfcf4f8da4e7e47568a5d530112ac760fec58f6429e65a9c68c9fa43503879fc30ade3f2261c8ed4b6311ff6161"} 13:43:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:17 INFO - Contents: 13:43:17 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8301cbdba9a186cd80594cf5fac2094f5d4c79c6821271eea1652fc90b8b4b749a1b7b1d753e50d25e9f57aa58bfa7a393598dac55123f99242d3f7f07b63afd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f293ab289a385d1ce2d07fd39b6d4032c7c910e44be1dae2c5ea70be1c08c43f699d3eefd252bd36b1eb63abb64f58c94474edf6478d7f9c17e9dd1a1f72118", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69d2c510377cf660b03e2baae6391d2b70210604f2e3658a9250a46e19957a244713a80143c2fcae23e376fa746715cbe34f1cdcf822a9d57a3b01dd9a2aaf8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ba7e2bed1030c2348eedb0793f652a42002cfcf4f8da4e7e47568a5d530112ac760fec58f6429e65a9c68c9fa43503879fc30ade3f2261c8ed4b6311ff6161"} 13:43:17 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:17 INFO - Copying logs to upload dir... 13:43:17 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.364210 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-04 13:43:17.196159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:17.203807) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8301cbdba9a186cd80594cf5fac2094f5d4c79c6821271eea1652fc90b8b4b749a1b7b1d753e50d25e9f57aa58bfa7a393598dac55123f99242d3f7f07b63afd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f293ab289a385d1ce2d07fd39b6d4032c7c910e44be1dae2c5ea70be1c08c43f699d3eefd252bd36b1eb63abb64f58c94474edf6478d7f9c17e9dd1a1f72118", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69d2c510377cf660b03e2baae6391d2b70210604f2e3658a9250a46e19957a244713a80143c2fcae23e376fa746715cbe34f1cdcf822a9d57a3b01dd9a2aaf8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ba7e2bed1030c2348eedb0793f652a42002cfcf4f8da4e7e47568a5d530112ac760fec58f6429e65a9c68c9fa43503879fc30ade3f2261c8ed4b6311ff6161"} build_url:https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8301cbdba9a186cd80594cf5fac2094f5d4c79c6821271eea1652fc90b8b4b749a1b7b1d753e50d25e9f57aa58bfa7a393598dac55123f99242d3f7f07b63afd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f293ab289a385d1ce2d07fd39b6d4032c7c910e44be1dae2c5ea70be1c08c43f699d3eefd252bd36b1eb63abb64f58c94474edf6478d7f9c17e9dd1a1f72118", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69d2c510377cf660b03e2baae6391d2b70210604f2e3658a9250a46e19957a244713a80143c2fcae23e376fa746715cbe34f1cdcf822a9d57a3b01dd9a2aaf8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ba7e2bed1030c2348eedb0793f652a42002cfcf4f8da4e7e47568a5d530112ac760fec58f6429e65a9c68c9fa43503879fc30ade3f2261c8ed4b6311ff6161"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:17.231944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:17.232334) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1501876941.153366-334500000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:17.314699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 13:43:17.315061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 13:43:17.318565) ========= ========= Total master_lag: 0.24 =========