builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1501197123.2 results: success (0) revision: 0379882c11f6d72f11d265036fc815e73b9ef5b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.196225) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.196603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.196868) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.225841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.226079) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 16:12:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-07-27 16:12:03 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150345 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.401682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.401959) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019744 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:03.471806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-27 16:12:03.472096) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0379882c11f6d72f11d265036fc815e73b9ef5b2 --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 0379882c11f6d72f11d265036fc815e73b9ef5b2 --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=14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 16:12:03,578 truncating revision to first 12 chars 2017-07-27 16:12:03,578 Setting DEBUG logging. 2017-07-27 16:12:03,578 attempt 1/10 2017-07-27 16:12:03,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0379882c11f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 16:12:04,589 unpacking tar archive at: mozilla-central-0379882c11f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.344364 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-27 16:12:04.845655) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:04.845960) ========= script_repo_revision: 0379882c11f6d72f11d265036fc815e73b9ef5b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:04.846331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:04.846604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:12:04.855944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-27 16:12:04.856248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:12:05 INFO - MultiFileLogger online at 20170727 16:12:05 in /builds/slave/test 16:12:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:12:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:05 INFO - {'append_to_log': False, 16:12:05 INFO - 'base_work_dir': '/builds/slave/test', 16:12:05 INFO - 'blob_upload_branch': 'Firefox', 16:12:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:05 INFO - 'branch': 'Firefox', 16:12:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:05 INFO - 'code_coverage': False, 16:12:05 INFO - 'config_files': ('talos/linux_config.py',), 16:12:05 INFO - 'default_actions': ('clobber', 16:12:05 INFO - 'read-buildbot-config', 16:12:05 INFO - 'download-and-extract', 16:12:05 INFO - 'populate-webroot', 16:12:05 INFO - 'create-virtualenv', 16:12:05 INFO - 'install', 16:12:05 INFO - 'setup-mitmproxy', 16:12:05 INFO - 'run-tests'), 16:12:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:05 INFO - 'disable_ccov_upload': False, 16:12:05 INFO - 'download_minidump_stackwalk': True, 16:12:05 INFO - 'download_symbols': 'ondemand', 16:12:05 INFO - 'enable_stylo': False, 16:12:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:05 INFO - 'gecko_profile': False, 16:12:05 INFO - 'gecko_profile_interval': 0, 16:12:05 INFO - 'installer_path': 'installer.exe', 16:12:05 INFO - 'log_level': 'info', 16:12:05 INFO - 'log_name': 'talos', 16:12:05 INFO - 'log_to_console': True, 16:12:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:12:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:12:05 INFO - 'opt_config_files': (), 16:12:05 INFO - 'pip_index': False, 16:12:05 INFO - 'suite': 'dromaeojs-e10s', 16:12:05 INFO - 'system_bits': '32', 16:12:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:05 INFO - 'title': 'talos-linux64-ix-036', 16:12:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:05 INFO - 'use_talos_json': True, 16:12:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:05 INFO - 'work_dir': 'build'} 16:12:05 INFO - [mozharness: 2017-07-27 23:12:05.061163Z] Running clobber step. 16:12:05 INFO - Running pre-action listener: _resource_record_pre_action 16:12:05 INFO - Running main action method: clobber 16:12:05 INFO - rmtree: /builds/slave/test/build 16:12:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:06 INFO - Running post-action listener: _resource_record_post_action 16:12:06 INFO - [mozharness: 2017-07-27 23:12:06.098671Z] Finished clobber step (success) 16:12:06 INFO - [mozharness: 2017-07-27 23:12:06.098773Z] Running read-buildbot-config step. 16:12:06 INFO - Running pre-action listener: _resource_record_pre_action 16:12:06 INFO - Running main action method: read_buildbot_config 16:12:06 INFO - Using buildbot properties: 16:12:06 INFO - { 16:12:06 INFO - "project": "", 16:12:06 INFO - "product": "firefox", 16:12:06 INFO - "who": "mh@glandium.org", 16:12:06 INFO - "installer_path": "public/build/target.tar.bz2", 16:12:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:12:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:12:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:12:06 INFO - "stage_platform": "linux64-stylo", 16:12:06 INFO - "basedir": "/builds/slave/test", 16:12:06 INFO - "buildnumber": 6, 16:12:06 INFO - "platform": "ubuntu64_hw_stylo", 16:12:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:12:06 INFO - "slavebuilddir": "test", 16:12:06 INFO - "taskId": "RdeLUmQbScOtt4pmXg1jiQ", 16:12:06 INFO - "branch": "mozilla-central", 16:12:06 INFO - "script_repo_revision": "production", 16:12:06 INFO - "revision": "0379882c11f6d72f11d265036fc815e73b9ef5b2", 16:12:06 INFO - "slavename": "talos-linux64-ix-036", 16:12:06 INFO - "repo_path": "mozilla-central" 16:12:06 INFO - } 16:12:06 INFO - Finding installer, test and symbols from parent task. 16:12:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdeLUmQbScOtt4pmXg1jiQ'}, attempt #1 16:12:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdeLUmQbScOtt4pmXg1jiQ'}, attempt #1 16:12:07 INFO - Task dependencies: ZqZj14WcSnmyjGd7pzYZYQ 16:12:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ'}, attempt #1 16:12:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/test_packages.json 16:12:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip 16:12:07 INFO - Running post-action listener: _resource_record_post_action 16:12:07 INFO - [mozharness: 2017-07-27 23:12:07.450075Z] Finished read-buildbot-config step (success) 16:12:07 INFO - [mozharness: 2017-07-27 23:12:07.450296Z] Running download-and-extract step. 16:12:07 INFO - Running pre-action listener: _resource_record_pre_action 16:12:07 INFO - Running main action method: download_and_extract 16:12:07 INFO - mkdir: /builds/slave/test/build/tests 16:12: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')]} 16:12:07 INFO - trying https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.test_packages.json 16:12:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:12:08 INFO - Downloaded 989 bytes. 16:12:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:12:08 INFO - Using the following test package requirements: 16:12:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:12:08 INFO - u'common': [u'target.common.tests.zip'], 16:12:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:12:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:12:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:12:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:12:08 INFO - u'mozbase': [u'target.common.tests.zip'], 16:12:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:12:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:12:08 INFO - u'web-platform': [u'target.common.tests.zip', 16:12:08 INFO - u'target.web-platform.tests.tar.gz'], 16:12:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:12:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:12:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip 16:12:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:12:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip into memory 16:12:11 INFO - Content-Length response header: 72558369 16:12:11 INFO - Bytes received: 72558369 16:12:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip 16:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip into memory 16:12:25 INFO - Content-Length response header: 72558369 16:12:25 INFO - Bytes received: 72558369 16:12:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.talos.tests.zip 16:12:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:12:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.talos.tests.zip into memory 16:12:38 INFO - Content-Length response header: 14496465 16:12:38 INFO - Bytes received: 14496465 16:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:38 INFO - trying https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:12:40 INFO - Downloaded 62158492 bytes. 16:12:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:40 INFO - mkdir: /builds/slave/test/properties 16:12:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:40 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:40 INFO - Contents: 16:12:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:40 INFO - Running post-action listener: _resource_record_post_action 16:12:40 INFO - Running post-action listener: set_extra_try_arguments 16:12:40 INFO - [mozharness: 2017-07-27 23:12:40.139201Z] Finished download-and-extract step (success) 16:12:40 INFO - [mozharness: 2017-07-27 23:12:40.139298Z] Running populate-webroot step. 16:12:40 INFO - Running pre-action listener: _resource_record_pre_action 16:12:40 INFO - Running main action method: populate_webroot 16:12:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:12:40 INFO - 'tests': ['damp', 'tps']}, 16:12:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:12:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:12:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:12:40 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:40 INFO - 'ts_paint', 16:12:40 INFO - 'tpaint', 16:12:40 INFO - 'sessionrestore', 16:12:40 INFO - 'sessionrestore_many_windows', 16:12:40 INFO - 'sessionrestore_no_auto_restore', 16:12:40 INFO - 'tabpaint']}, 16:12:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:12:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:12:40 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:40 INFO - 'talos_options': ['--mitmproxy', 16:12:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:40 INFO - '--firstNonBlankPaint'], 16:12:40 INFO - 'tests': ['quantum_pageload_google', 16:12:40 INFO - 'quantum_pageload_youtube', 16:12:40 INFO - 'quantum_pageload_amazon', 16:12:40 INFO - 'quantum_pageload_facebook']}, 16:12:40 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:40 INFO - 'talos_options': ['--stylo', 16:12:40 INFO - '--mitmproxy', 16:12:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:40 INFO - '--firstNonBlankPaint'], 16:12:40 INFO - 'tests': ['quantum_pageload_google', 16:12:40 INFO - 'quantum_pageload_youtube', 16:12:40 INFO - 'quantum_pageload_amazon', 16:12:40 INFO - 'quantum_pageload_facebook']}, 16:12:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:40 INFO - 'tsvgr_opacity', 16:12:40 INFO - 'tart', 16:12:40 INFO - 'tscrollx', 16:12:40 INFO - 'cart', 16:12:40 INFO - 'tsvg_static']}, 16:12:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:12:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:12:40 INFO - 'talos_options': ['--xperf_path', 16:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:40 INFO - 'tests': ['tp5n']}}} 16:12:40 INFO - Running post-action listener: _resource_record_post_action 16:12:40 INFO - [mozharness: 2017-07-27 23:12:40.146584Z] Finished populate-webroot step (success) 16:12:40 INFO - [mozharness: 2017-07-27 23:12:40.146673Z] Running create-virtualenv step. 16:12:40 INFO - Running pre-action listener: _resource_record_pre_action 16:12:40 INFO - Running main action method: create_virtualenv 16:12:40 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:40 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 16:12:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:12:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:40 INFO - Using real prefix '/usr' 16:12:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:42 INFO - Installing pip.................done. 16:12:42 INFO - Return code: 0 16:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:12:42 INFO - Reading from file tmpfile_stdout 16:12:42 INFO - Output received: 16:12:42 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) 16:12:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:42 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:42 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 16:12:42 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 16:12:42 INFO - Using env: {'DISPLAY': ':0', 16:12:42 INFO - 'HOME': '/home/cltbld', 16:12:42 INFO - 'LANG': 'en_US.UTF-8', 16:12:42 INFO - 'LANGUAGE': 'en_US:en', 16:12:42 INFO - 'LOGNAME': 'cltbld', 16:12:42 INFO - 'MAIL': '/var/mail/cltbld', 16:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:42 INFO - 'MOZ_NO_REMOTE': '1', 16:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:42 INFO - 'NO_EM_RESTART': '1', 16:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:42 INFO - 'PWD': '/builds/slave/test', 16:12:42 INFO - 'SHELL': '/bin/bash', 16:12:42 INFO - 'SHLVL': '1', 16:12:42 INFO - 'TERM': 'linux', 16:12:42 INFO - 'TMOUT': '86400', 16:12:42 INFO - 'USER': 'cltbld', 16:12:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:42 INFO - '_': '/tools/buildbot/bin/python'} 16:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:43 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 16:12:43 INFO - Cleaning up... 16:12:43 INFO - Return code: 0 16:12:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:43 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')]} 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:43 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')]} 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:43 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:43 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 16:12:43 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 16:12:43 INFO - Using env: {'DISPLAY': ':0', 16:12:43 INFO - 'HOME': '/home/cltbld', 16:12:43 INFO - 'LANG': 'en_US.UTF-8', 16:12:43 INFO - 'LANGUAGE': 'en_US:en', 16:12:43 INFO - 'LOGNAME': 'cltbld', 16:12:43 INFO - 'MAIL': '/var/mail/cltbld', 16:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:43 INFO - 'MOZ_NO_REMOTE': '1', 16:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:43 INFO - 'NO_EM_RESTART': '1', 16:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:43 INFO - 'PWD': '/builds/slave/test', 16:12:43 INFO - 'SHELL': '/bin/bash', 16:12:43 INFO - 'SHLVL': '1', 16:12:43 INFO - 'TERM': 'linux', 16:12:43 INFO - 'TMOUT': '86400', 16:12:43 INFO - 'USER': 'cltbld', 16:12:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:43 INFO - '_': '/tools/buildbot/bin/python'} 16:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:43 INFO - Downloading/unpacking psutil>=3.1.1 16:12:43 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 16:12:43 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 16:12:43 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 16:12:43 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 16:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:44 INFO - Installing collected packages: psutil 16:12:44 INFO - Running setup.py install for psutil 16:12:44 INFO - building 'psutil._psutil_linux' extension 16:12:44 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 16:12:44 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 16:12:44 INFO - building 'psutil._psutil_posix' extension 16:12:44 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 16:12:44 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 16:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:45 INFO - Successfully installed psutil 16:12:45 INFO - Cleaning up... 16:12:45 INFO - Return code: 0 16:12:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:12:45 INFO - Using env: {'DISPLAY': ':0', 16:12:45 INFO - 'HOME': '/home/cltbld', 16:12:45 INFO - 'LANG': 'en_US.UTF-8', 16:12:45 INFO - 'LANGUAGE': 'en_US:en', 16:12:45 INFO - 'LOGNAME': 'cltbld', 16:12:45 INFO - 'MAIL': '/var/mail/cltbld', 16:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:45 INFO - 'MOZ_NO_REMOTE': '1', 16:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:45 INFO - 'NO_EM_RESTART': '1', 16:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:45 INFO - 'PWD': '/builds/slave/test', 16:12:45 INFO - 'SHELL': '/bin/bash', 16:12:45 INFO - 'SHLVL': '1', 16:12:45 INFO - 'TERM': 'linux', 16:12:45 INFO - 'TMOUT': '86400', 16:12:45 INFO - 'USER': 'cltbld', 16:12:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:45 INFO - '_': '/tools/buildbot/bin/python'} 16:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:45 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 16:12:45 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 16:12:45 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 16:12:45 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 16:12:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:46 INFO - Installing collected packages: mozsystemmonitor 16:12:46 INFO - Running setup.py install for mozsystemmonitor 16:12:46 INFO - Successfully installed mozsystemmonitor 16:12:46 INFO - Cleaning up... 16:12:46 INFO - Return code: 0 16:12:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:46 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')]} 16:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:46 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')]} 16:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:46 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:46 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 16:12:46 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 16:12:46 INFO - Using env: {'DISPLAY': ':0', 16:12:46 INFO - 'HOME': '/home/cltbld', 16:12:46 INFO - 'LANG': 'en_US.UTF-8', 16:12:46 INFO - 'LANGUAGE': 'en_US:en', 16:12:46 INFO - 'LOGNAME': 'cltbld', 16:12:46 INFO - 'MAIL': '/var/mail/cltbld', 16:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:46 INFO - 'MOZ_NO_REMOTE': '1', 16:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:46 INFO - 'NO_EM_RESTART': '1', 16:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:46 INFO - 'PWD': '/builds/slave/test', 16:12:46 INFO - 'SHELL': '/bin/bash', 16:12:46 INFO - 'SHLVL': '1', 16:12:46 INFO - 'TERM': 'linux', 16:12:46 INFO - 'TMOUT': '86400', 16:12:46 INFO - 'USER': 'cltbld', 16:12:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:46 INFO - '_': '/tools/buildbot/bin/python'} 16:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:46 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:46 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 16:12:46 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 16:12:46 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 16:12:46 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 16:12:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:48 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:48 INFO - warning: no files found matching '*.txt' 16:12:48 INFO - no previously-included directories found matching 'build' 16:12:48 INFO - no previously-included directories found matching 'dist' 16:12:48 INFO - no previously-included directories found matching '.git*' 16:12:48 INFO - Installing collected packages: jsonschema, functools32 16:12:48 INFO - Running setup.py install for functools32 16:12:48 INFO - warning: no files found matching '*.txt' 16:12:48 INFO - no previously-included directories found matching 'build' 16:12:48 INFO - no previously-included directories found matching 'dist' 16:12:48 INFO - no previously-included directories found matching '.git*' 16:12:48 INFO - Successfully installed jsonschema functools32 16:12:48 INFO - Cleaning up... 16:12:48 INFO - Return code: 0 16:12:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:48 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')]} 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:48 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')]} 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:48 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:48 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 16:12:48 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 16:12:48 INFO - Using env: {'DISPLAY': ':0', 16:12:48 INFO - 'HOME': '/home/cltbld', 16:12:48 INFO - 'LANG': 'en_US.UTF-8', 16:12:48 INFO - 'LANGUAGE': 'en_US:en', 16:12:48 INFO - 'LOGNAME': 'cltbld', 16:12:48 INFO - 'MAIL': '/var/mail/cltbld', 16:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:48 INFO - 'MOZ_NO_REMOTE': '1', 16:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:48 INFO - 'NO_EM_RESTART': '1', 16:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:48 INFO - 'PWD': '/builds/slave/test', 16:12:48 INFO - 'SHELL': '/bin/bash', 16:12:48 INFO - 'SHLVL': '1', 16:12:48 INFO - 'TERM': 'linux', 16:12:48 INFO - 'TMOUT': '86400', 16:12:48 INFO - 'USER': 'cltbld', 16:12:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:48 INFO - '_': '/tools/buildbot/bin/python'} 16:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:48 INFO - Cleaning up... 16:12:48 INFO - Return code: 0 16:12:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:48 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')]} 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:48 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')]} 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:48 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:48 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 16:12:48 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 16:12:48 INFO - Using env: {'DISPLAY': ':0', 16:12:48 INFO - 'HOME': '/home/cltbld', 16:12:48 INFO - 'LANG': 'en_US.UTF-8', 16:12:48 INFO - 'LANGUAGE': 'en_US:en', 16:12:48 INFO - 'LOGNAME': 'cltbld', 16:12:48 INFO - 'MAIL': '/var/mail/cltbld', 16:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:48 INFO - 'MOZ_NO_REMOTE': '1', 16:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:48 INFO - 'NO_EM_RESTART': '1', 16:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:48 INFO - 'PWD': '/builds/slave/test', 16:12:48 INFO - 'SHELL': '/bin/bash', 16:12:48 INFO - 'SHLVL': '1', 16:12:48 INFO - 'TERM': 'linux', 16:12:48 INFO - 'TMOUT': '86400', 16:12:48 INFO - 'USER': 'cltbld', 16:12:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:48 INFO - '_': '/tools/buildbot/bin/python'} 16:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:48 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 16:12:48 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 16:12:48 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 16:12:48 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 16:12:50 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:50 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 16:12:50 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 16:12:50 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 16:12:50 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 16:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:51 INFO - Downloading docopt-0.6.1.tar.gz 16:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:51 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:51 INFO - Running setup.py install for blobuploader 16:12:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:51 INFO - Running setup.py install for requests 16:12:51 INFO - Running setup.py install for docopt 16:12:51 INFO - Successfully installed blobuploader requests docopt 16:12:51 INFO - Cleaning up... 16:12:51 INFO - Return code: 0 16:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:51 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:51 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 16:12:51 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 16:12:51 INFO - Using env: {'DISPLAY': ':0', 16:12:51 INFO - 'HOME': '/home/cltbld', 16:12:51 INFO - 'LANG': 'en_US.UTF-8', 16:12:51 INFO - 'LANGUAGE': 'en_US:en', 16:12:51 INFO - 'LOGNAME': 'cltbld', 16:12:51 INFO - 'MAIL': '/var/mail/cltbld', 16:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:51 INFO - 'MOZ_NO_REMOTE': '1', 16:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:51 INFO - 'NO_EM_RESTART': '1', 16:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:51 INFO - 'PWD': '/builds/slave/test', 16:12:51 INFO - 'SHELL': '/bin/bash', 16:12:51 INFO - 'SHLVL': '1', 16:12:51 INFO - 'TERM': 'linux', 16:12:51 INFO - 'TMOUT': '86400', 16:12:51 INFO - 'USER': 'cltbld', 16:12:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:51 INFO - '_': '/tools/buildbot/bin/python'} 16:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:52 INFO - Running setup.py (path:/tmp/pip-9PgWpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:52 INFO - Running setup.py (path:/tmp/pip-svd9Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:52 INFO - Running setup.py (path:/tmp/pip-_Nat4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:52 INFO - Running setup.py (path:/tmp/pip-7b5SNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:52 INFO - Running setup.py (path:/tmp/pip-NMxkLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:52 INFO - Running setup.py (path:/tmp/pip-x5p83K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:52 INFO - Running setup.py (path:/tmp/pip-8b5v00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:52 INFO - Running setup.py (path:/tmp/pip-AGfbP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:52 INFO - Running setup.py (path:/tmp/pip-kb_i0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:52 INFO - Running setup.py (path:/tmp/pip-5f4tu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:52 INFO - Running setup.py (path:/tmp/pip-wZyb6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:52 INFO - Running setup.py (path:/tmp/pip-YGCOOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:53 INFO - Running setup.py (path:/tmp/pip-ZFg7o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:53 INFO - Running setup.py (path:/tmp/pip-An6k5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:53 INFO - Running setup.py (path:/tmp/pip-MHHbiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:53 INFO - Running setup.py (path:/tmp/pip-fbkBTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:53 INFO - Running setup.py (path:/tmp/pip-aJMSo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:53 INFO - Running setup.py install for manifestparser 16:12:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:53 INFO - Running setup.py install for mozcrash 16:12:53 INFO - Running setup.py install for mozdebug 16:12:53 INFO - Running setup.py install for mozdevice 16:12:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:53 INFO - Running setup.py install for mozfile 16:12:53 INFO - Running setup.py install for mozhttpd 16:12:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for mozinfo 16:12:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for mozInstall 16:12:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for mozleak 16:12:54 INFO - Running setup.py install for mozlog 16:12:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for moznetwork 16:12:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for mozprocess 16:12:54 INFO - Running setup.py install for mozprofile 16:12:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for mozrunner 16:12:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:54 INFO - Running setup.py install for mozscreenshot 16:12:54 INFO - Running setup.py install for moztest 16:12:55 INFO - Running setup.py install for mozversion 16:12:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:55 INFO - Cleaning up... 16:12:55 INFO - Return code: 0 16:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:55 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:55 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 16:12:55 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 16:12:55 INFO - Using env: {'DISPLAY': ':0', 16:12:55 INFO - 'HOME': '/home/cltbld', 16:12:55 INFO - 'LANG': 'en_US.UTF-8', 16:12:55 INFO - 'LANGUAGE': 'en_US:en', 16:12:55 INFO - 'LOGNAME': 'cltbld', 16:12:55 INFO - 'MAIL': '/var/mail/cltbld', 16:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:55 INFO - 'MOZ_NO_REMOTE': '1', 16:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:55 INFO - 'NO_EM_RESTART': '1', 16:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:55 INFO - 'PWD': '/builds/slave/test', 16:12:55 INFO - 'SHELL': '/bin/bash', 16:12:55 INFO - 'SHLVL': '1', 16:12:55 INFO - 'TERM': 'linux', 16:12:55 INFO - 'TMOUT': '86400', 16:12:55 INFO - 'USER': 'cltbld', 16:12:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:55 INFO - '_': '/tools/buildbot/bin/python'} 16:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:55 INFO - Running setup.py (path:/tmp/pip-GPTzQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:55 INFO - Running setup.py (path:/tmp/pip-27XGUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:55 INFO - Running setup.py (path:/tmp/pip-uUIOr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:55 INFO - Running setup.py (path:/tmp/pip-v7QhkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:55 INFO - Running setup.py (path:/tmp/pip-IFAf1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:55 INFO - Running setup.py (path:/tmp/pip-7rjaTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:55 INFO - Running setup.py (path:/tmp/pip-YmSjCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:55 INFO - Running setup.py (path:/tmp/pip-h8SeRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:55 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)) 16:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:55 INFO - Running setup.py (path:/tmp/pip-fHDX3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:56 INFO - Running setup.py (path:/tmp/pip-3JBWWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:56 INFO - Running setup.py (path:/tmp/pip-Ml9OwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:56 INFO - Running setup.py (path:/tmp/pip-R9XmEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:56 INFO - Running setup.py (path:/tmp/pip-g51qsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:56 INFO - Running setup.py (path:/tmp/pip-Wz74QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:56 INFO - Running setup.py (path:/tmp/pip-g3sZkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:56 INFO - Running setup.py (path:/tmp/pip-lYuUXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:56 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)) 16:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:56 INFO - Running setup.py (path:/tmp/pip-9TfStU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:56 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)) 16:12:56 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)) 16:12:56 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)) 16:12:56 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)) 16:12:56 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)) 16:12:56 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)) 16:12:56 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)) 16:12:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:57 INFO - Downloading blessings-1.6.tar.gz 16:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:57 INFO - Installing collected packages: blessings 16:12:57 INFO - Running setup.py install for blessings 16:12:57 INFO - Successfully installed blessings 16:12:57 INFO - Cleaning up... 16:12:57 INFO - Return code: 0 16:12:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:58 INFO - Reading from file tmpfile_stdout 16:12:58 INFO - Current package versions: 16:12:58 INFO - argparse == 1.2.1 16:12:58 INFO - blessings == 1.6 16:12:58 INFO - blobuploader == 1.2.4 16:12:58 INFO - docopt == 0.6.1 16:12:58 INFO - functools32 == 3.2.3-2 16:12:58 INFO - jsonschema == 2.5.1 16:12:58 INFO - manifestparser == 1.1 16:12:58 INFO - mozInstall == 1.13 16:12:58 INFO - mozcrash == 1.0 16:12:58 INFO - mozdebug == 0.1 16:12:58 INFO - mozdevice == 0.51 16:12:58 INFO - mozfile == 1.2 16:12:58 INFO - mozhttpd == 0.7 16:12:58 INFO - mozinfo == 0.10 16:12:58 INFO - mozleak == 0.1 16:12:58 INFO - mozlog == 3.5 16:12:58 INFO - moznetwork == 0.27 16:12:58 INFO - mozprocess == 0.25 16:12:58 INFO - mozprofile == 0.28 16:12:58 INFO - mozrunner == 6.13 16:12:58 INFO - mozscreenshot == 0.1 16:12:58 INFO - mozsystemmonitor == 0.3 16:12:58 INFO - moztest == 0.8 16:12:58 INFO - mozversion == 1.4 16:12:58 INFO - psutil == 3.1.1 16:12:58 INFO - requests == 1.2.3 16:12:58 INFO - wsgiref == 0.1.2 16:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:58 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 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:12:58 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 16:12:58 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 16:12:58 INFO - Using env: {'DISPLAY': ':0', 16:12:58 INFO - 'HOME': '/home/cltbld', 16:12:58 INFO - 'LANG': 'en_US.UTF-8', 16:12:58 INFO - 'LANGUAGE': 'en_US:en', 16:12:58 INFO - 'LOGNAME': 'cltbld', 16:12:58 INFO - 'MAIL': '/var/mail/cltbld', 16:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:58 INFO - 'MOZ_NO_REMOTE': '1', 16:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:58 INFO - 'NO_EM_RESTART': '1', 16:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:58 INFO - 'PWD': '/builds/slave/test', 16:12:58 INFO - 'SHELL': '/bin/bash', 16:12:58 INFO - 'SHLVL': '1', 16:12:58 INFO - 'TERM': 'linux', 16:12:58 INFO - 'TMOUT': '86400', 16:12:58 INFO - 'USER': 'cltbld', 16:12:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:58 INFO - '_': '/tools/buildbot/bin/python'} 16:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 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)) 16:12:58 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:59 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:12:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:12:59 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)) 16:12:59 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)) 16:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:59 INFO - Installing collected packages: marionette-driver, simplejson 16:12:59 INFO - Running setup.py install for marionette-driver 16:12:59 INFO - Running setup.py install for simplejson 16:12:59 INFO - building 'simplejson._speedups' extension 16:12:59 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 16:13:00 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 16:13:00 INFO - Successfully installed marionette-driver simplejson 16:13:00 INFO - Cleaning up... 16:13:00 INFO - Return code: 0 16:13:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, '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': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', '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 16:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:13:00 INFO - Using env: {'DISPLAY': ':0', 16:13:00 INFO - 'HOME': '/home/cltbld', 16:13:00 INFO - 'LANG': 'en_US.UTF-8', 16:13:00 INFO - 'LANGUAGE': 'en_US:en', 16:13:00 INFO - 'LOGNAME': 'cltbld', 16:13:00 INFO - 'MAIL': '/var/mail/cltbld', 16:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:00 INFO - 'MOZ_NO_REMOTE': '1', 16:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:00 INFO - 'NO_EM_RESTART': '1', 16:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:00 INFO - 'PWD': '/builds/slave/test', 16:13:00 INFO - 'SHELL': '/bin/bash', 16:13:00 INFO - 'SHLVL': '1', 16:13:00 INFO - 'TERM': 'linux', 16:13:00 INFO - 'TMOUT': '86400', 16:13:00 INFO - 'USER': 'cltbld', 16:13:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:00 INFO - '_': '/tools/buildbot/bin/python'} 16:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:01 INFO - Cleaning up... 16:13:01 INFO - Return code: 0 16:13:01 INFO - Running post-action listener: _resource_record_post_action 16:13:01 INFO - Running post-action listener: _start_resource_monitoring 16:13:01 INFO - Starting resource monitoring. 16:13:01 INFO - [mozharness: 2017-07-27 23:13:01.192093Z] Finished create-virtualenv step (success) 16:13:01 INFO - [mozharness: 2017-07-27 23:13:01.192557Z] Running install step. 16:13:01 INFO - Running pre-action listener: _resource_record_pre_action 16:13:01 INFO - Running main action method: install 16:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:01 INFO - Reading from file tmpfile_stdout 16:13:01 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:01 INFO - Reading from file tmpfile_stdout 16:13:01 INFO - Output received: 16:13:01 INFO - Usage: mozinstall [options] installer 16:13:01 INFO - Options: 16:13:01 INFO - -h, --help show this help message and exit 16:13:01 INFO - -d DEST, --destination=DEST 16:13:01 INFO - Directory to install application into. [default: 16:13:01 INFO - "/builds/slave/test"] 16:13:01 INFO - --app=APP Application being installed. [default: firefox] 16:13:01 INFO - mkdir: /builds/slave/test/build/application 16:13:01 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'] 16:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:13:19 INFO - Reading from file tmpfile_stdout 16:13:19 INFO - Output received: 16:13:19 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:19 INFO - Running post-action listener: _resource_record_post_action 16:13:19 INFO - [mozharness: 2017-07-27 23:13:19.581617Z] Finished install step (success) 16:13:19 INFO - [mozharness: 2017-07-27 23:13:19.581871Z] Running setup-mitmproxy step. 16:13:19 INFO - Running pre-action listener: _resource_record_pre_action 16:13:19 INFO - Running main action method: setup_mitmproxy 16:13:19 INFO - Skipping: mitmproxy is not required 16:13:19 INFO - Running post-action listener: _resource_record_post_action 16:13:19 INFO - [mozharness: 2017-07-27 23:13:19.582992Z] Finished setup-mitmproxy step (success) 16:13:19 INFO - [mozharness: 2017-07-27 23:13:19.583213Z] Running run-tests step. 16:13:19 INFO - Running pre-action listener: _resource_record_pre_action 16:13:19 INFO - Running pre-action listener: _set_gcov_prefix 16:13:19 INFO - Running main action method: run_tests 16:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:19 INFO - Python 2.7.3 16:13:19 INFO - Return code: 0 16:13:19 INFO - grabbing minidump binary from tooltool 16:13:19 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')]} 16:13:19 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 0x2a21eb0>, '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 0x2a22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a23240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:19 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 16:13:19 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 16:13:19 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 16:13:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:19 INFO - Return code: 0 16:13:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:19 INFO - ENV: RUST_BACKTRACE is now 1 16:13:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 16:13:19 INFO - Using env: {'DISPLAY': ':0', 16:13:19 INFO - 'HOME': '/home/cltbld', 16:13:19 INFO - 'LANG': 'en_US.UTF-8', 16:13:19 INFO - 'LANGUAGE': 'en_US:en', 16:13:19 INFO - 'LOGNAME': 'cltbld', 16:13:19 INFO - 'MAIL': '/var/mail/cltbld', 16:13:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:19 INFO - 'MOZ_NO_REMOTE': '1', 16:13:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:19 INFO - 'NO_EM_RESTART': '1', 16:13:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:19 INFO - 'PWD': '/builds/slave/test', 16:13:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:19 INFO - 'RUST_BACKTRACE': '1', 16:13:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:13:19 INFO - 'SHELL': '/bin/bash', 16:13:19 INFO - 'SHLVL': '1', 16:13:19 INFO - 'STYLO_FORCE_ENABLED': '1', 16:13:19 INFO - 'TERM': 'linux', 16:13:19 INFO - 'TMOUT': '86400', 16:13:19 INFO - 'USER': 'cltbld', 16:13:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612', 16:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:19 INFO - '_': '/tools/buildbot/bin/python'} 16:13:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:13:19 INFO - mozversion application_buildid: 20170727222513 16:13:19 INFO - mozversion application_changeset: 0379882c11f6d72f11d265036fc815e73b9ef5b2 16:13:19 INFO - mozversion application_display_name: Nightly 16:13:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:19 INFO - mozversion application_name: Firefox 16:13:19 INFO - mozversion application_remotingname: firefox 16:13:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:13:19 INFO - mozversion application_vendor: Mozilla 16:13:19 INFO - mozversion application_version: 56.0a1 16:13:19 INFO - mozversion platform_buildid: 20170727222513 16:13:19 INFO - mozversion platform_changeset: 0379882c11f6d72f11d265036fc815e73b9ef5b2 16:13:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:13:19 INFO - mozversion platform_version: 56.0a1 16:13:19 INFO - using testdate: 1501197199 16:13:19 INFO - actual date: 1501197199 16:13:19 INFO - starting webserver on 'localhost:34585' 16:13:19 INFO - SUITE-START | Running 2 tests 16:13:19 INFO - TEST-START | dromaeo_css 16:13:19 INFO - Initialising browser for dromaeo_css test... 16:13:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34585/getInfo.html -profile /tmp/tmpeO2sox/profile 16:13:19 INFO - TEST-INFO | started process 32331 (/builds/slave/test/build/application/firefox/firefox http://localhost:34585/getInfo.html) 16:13:26 INFO - TEST-INFO | 32331: exit 0 16:13:26 INFO - Browser initialized. 16:13:26 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:26 INFO - TEST-INFO | started process 32560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeO2sox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:27 INFO - PID 32560 | 16:13:27 INFO - PID 32560 | (/builds/slave/test/build/application/firefox/firefox:32615): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:13:27 INFO - PID 32560 | 16:13:37 INFO - PID 32560 | RSS: Main: 173297664 16:13:37 INFO - PID 32560 | 16:16:37 INFO - PID 32560 | Cycle 1(1): loaded http://localhost:34585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34585/tests/dromaeo/cssquery-ext.html) 16:16:38 INFO - PID 32560 | RSS: Main: 174915584 16:16:38 INFO - PID 32560 | 16:19:40 INFO - PID 32560 | Cycle 1(1): loaded http://localhost:34585/tests/dromaeo/cssquery-ext.html (next: http://localhost:34585/tests/dromaeo/cssquery-jquery.html) 16:19:41 INFO - PID 32560 | RSS: Main: 172777472 16:19:41 INFO - PID 32560 | 16:22:42 INFO - PID 32560 | Cycle 1(1): loaded http://localhost:34585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34585/tests/dromaeo/cssquery-mootools.html) 16:22:43 INFO - PID 32560 | RSS: Main: 174030848 16:22:43 INFO - PID 32560 | 16:25:45 INFO - PID 32560 | Cycle 1(1): loaded http://localhost:34585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34585/tests/dromaeo/cssquery-prototype.html) 16:25:46 INFO - PID 32560 | RSS: Main: 173297664 16:25:46 INFO - PID 32560 | 16:28:50 INFO - PID 32560 | Cycle 1(1): loaded http://localhost:34585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34585/tests/dromaeo/cssquery-yui.html) 16:28:50 INFO - PID 32560 | RSS: Main: 174116864 16:28:50 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | Cycle 1(1): loaded http://localhost:34585/tests/dromaeo/cssquery-yui.html (next: http://localhost:34585/tests/dromaeo/cssquery-dojo.html) 16:31:52 INFO - PID 32560 | RSS: Main: 176664576 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | __start_tp_report 16:31:52 INFO - PID 32560 | _x_x_mozilla_page_load 16:31:52 INFO - PID 32560 | _x_x_mozilla_page_load_details 16:31:52 INFO - PID 32560 | |i|pagename|runs| 16:31:52 INFO - PID 32560 | |0;dojo.html;3088.382323535292;3108.7512998960087;3137.764667649926;3165.2561648012706;3187.6015498062743;6037.879242415154;6258.311585725566;6260.655663938482;6266.122742816009;6271.965125754256;6045.304789949146;6161;6171.876562468748;6219.440250377476;6236.251649802019;5686.431356864322;5691.7723291068305;5711.228984087136;5731.340895796974;5738.282714660668;5752.079667253241;5752.5110365618975;5755.079187330028;5756.539476841843;5772.942270577303;5686.3744988051285;5705.087186050233;5736.11090281005;5738.684372359518;5792.565557583198;5483.561315094823;5706.172604972297;5706.9429305707245;5783.190353350535;5792.82621521355;5616.803411880605;5628.26832511775;5661.46216109469;5719.771209151629;5728.914066289009;6028.668423236721;6077.483413909778;6102.26772787264;6160.84597885052;6213.5339849511465;6543.280239173687;6607.306232845578;6640.667966601651;6709.09427227323;6721.462283017347;6756.527043106985;6792.830179245509;6816.522843400964;6822.795316140524;6827.044213810071;6277.058441233806;6278;6283.963146080891;6284.528660350446;6288.52836037299;6883.586984780929;6885.724571017103;6919.688614012382;6956.060931774247;6957.9304206958295;6461.483081353481;6485.4811615070685;6537.509686773511;6559.770408035696;6563.245226798884;6611.140551728245;6614.272430032693;6622.403983641495;6633.900491492632;6711.362420570038;6616.206055273302;6657.567258128303;6710.932890671128;6718.798436046926;6725.159355080615;6684.732610695518;6685.832854178587;6706.731730730814;6777.288384719632;6778.762743303961;5195.532402083831;5254;5296.92054619181;5301.840944771663;5393.244945707525;4578.107269082563;4606.700564463366;4625.560571745679;4634.165850147006;4639.791209395586;5734.942650573441;5806.303243610793;5823.475887170175;5855.326637436664;5859.53123750099;6638.0374845648075;6681.064650948871;6682.832929176712;6748.325167483311;6775.254721980578;5704.543636509153;5785.595008349375;5791.247137872134;5878.177055212273;5879.412058794172;5900.793472228452;5917.497012753878;5923.970380148072;5924.081767326072;5927.673977931169;6445.097686323918;6517.3808488193545;6541.934580654228;6557.377049180415;6584.604923704593;6602.306757790555;6637.336266373517;6689.09697190873;6708.731650733916;6735.393814556714;6366.586171898812;6463.935360646334;6472.126262954629;6556.2788093308745;6571.507136964651;6531;6584.407403333723;6618.735250590115;6635;6643.936970084763;6707.128073350434;6754.324567543206;6802.761903333359;6808.421284190701;6818.249992500921;6510.056041873996;6586.736530538917;6601.834954126185;6608.306127856506;6615.272320044887;6477.4170324671;6483.09236706852;6577.572457790228;6583.407493325623;6588.374104460068;6332.715027823667;6430.061802736699;6437.324080971618;6457.031445283245;6457.67711614408;6509.349065093453;6523.3150519194805;6537.967310163609;6615.37153970372;6674.365935236145;6219.067139929047;6284.74861005573;6316.242050953915;6357.237131544244;6398.328175541687 16:31:52 INFO - PID 32560 | |1;ext.html;821.7699044267607;846.7840700621341;869.6521391443422;869.9869501957468;1184.9881501184987;32056.839715801416;42640.786796066015;43352.78323608385;43422.565774342285;43452.56547434525;43723;43861.7806910965;43916.56083439165;44026.33960490595;44207.115857682904;7803.7658870233845;7954.16481269467;7963.482373645724;7974.0431148262;7976.122626511079;7722.884156737626;7777.572233527154;7789.298963093321;7798.961005194995;7840.529568225897;7777.961110194441;7833.41249406294;7894.407919406039;7962.840743185133;7977.321927636158;7826.413019023567;7890.8816367754525;7896.170902055288;7916.287534121899;7953.483023603448;7568.205338439439;7795.33739632132;7847.607619618996;7923.960380198062;7925.7622271331375;39714;40057;40116.197676046315;40200;40203;3545.166885781839;3556.964430355715;3597.460380942853;3598.7660802048044;3599.748017638766;31633.683663163305;31859.84070079658;31963.360732785215;32163.678363216302;32222.355552889047;4779.856604301876;4801.375821143264;4808.879778005543;4837.395325584302;4886.438059623153;186320;187253;187526;187803;188142;48722;48894.51105488899;48929.26606100911;48961.51038489569;49012;51441.485585143666;51494.742526287126;51596.48403515992;51646.22530662043;51932;17248.741268880978;17294.740578891327;17297.91351043262;17368.044757538457;17368.305267789146;14113.647158820906;14160;14183.85816141846;14195.645108872155;14195.64510887236;13032.739345213042;14237.857621423653;14444.638884027983;14612.561623151323;14711.190884501455;5009.522190953678;6033.215681961317;6349.809505714836;6381.946978748548;6400.55196136266;981.9705408837747;981.9852702209473;997.2719914462483;1009.848522721583;1016.1362841584594;23188.88405557995;23397.88301058484;23428.414289642897;23752.88123559371;23971.640425393634;1075.2097208551866;1104.9502772375263;1110.4114819145866;1112.5994641928899;1113.3598181045932;11879.290118064084;12382.938085309515;15899.920500397424;16124.596885077966;16269.918650406673;230047;231626;231752;231762;232714;58331;58398.41601584015;58567;58623.706881466176;58768.41231587715;1460.5764328344874;1493.320539154682;1493.5370035288877;1505.2548988250885;1508.3891024135244;26894.462110757286;27669;27691;27696.584551231346;27872.44255114927;53817;54612.72693636506;54654.180187298014;54655;54659.72670136783;194755;194793;195317;196979;197125;36143.45784813177;36236;36506.634933650326;36809.81595092007;36885.077873053386;41526.792366037975;45574.54425455703;45630.54369456396;46760.7661961688;47463.762681186374;32315.19212019718;32831.67168328286;32903.34193316168;33092.33815323632;33463;29758.85120574383;30892.691073088983;32223;32601.673983259865;32622.34755304833;37147.62852371442;39601.207975840895;39633.80183099066;39911.40132897951;40092;33726.49410258897;34466.31067378689;34688.65311346854;34989.825050874584;44109.55890441054;29688.851555742083;29716;30746;30927.69072309248;31341.529877051405 16:31:52 INFO - PID 32560 | |2;jquery.html;569.3566270114769;571.2488078177199;575.2923903598572;580.6371018113682;588.632104934416;21716.131354745812;22469.21357752479;22764.658530122062;22803.429914252152;23624.763752362473;24807;25438.236852894395;25458;25471;25775.613365799527;6407.263164736069;6537.77117800877;6538.280789113193;6544.640044797558;6550.770723024695;5948.643081415107;6246.656433896134;6466.547341686084;6540.37866402691;6555.868882622344;6507.381798729113;6517.989711594711;6523.7064332105165;6526.934730652704;6527.086207930894;6465.418112369863;6473.546851720382;6485.2217733872;6505.869882602345;6520.0871877937125;6067.666278354689;6074.088886667036;6074.936886044925;6076.848078798022;6078.270607527081;28442.857785710938;29012.27469313263;31291;32577;32644.347113057607;1865.0767869904348;1901.5721462670926;1911.0635788463692;1912.2542208538541;1912.3306842605116;19617;20496.38510844677;20618;20820.791792082036;20855.270065547633;2389.7968672662846;2447.36368544178;2485.5898776701824;2489.041718938222;2580.9612855807177;131181;133349;133366.33316833354;135604.3219783895;138586.61413385838;20974.685379719318;21638.996785594714;21654.942780436148;22266.443338916655;22417.887910560345;42968.14063718708;42989.35515967263;43197;43291;43369.34945975813;11913.761724765456;12072.758544829054;12163.452644631012;12197.573084941985;12359.938200309121;9944.30389872702;10087.142592879542;10087.49562521871;10155.644552440777;10335.121514671187;9544.33189676716;10770.192235582363;11161.386123763272;11680.532778688757;11707.121965852424;3646.59606051672;3716.479692843004;3727.422249551324;4209.642180414638;4253.128108737701;937.6811883959487;948.4878165790396;971.3686104032295;971.868797712314;972.9805403891883;19299;19479.8052019478;19690.803091968897;19839.206431742856;20018.399448016582;1002.1982414068716;1008.5713571731984;1027.4605831938143;1028.9588416463257;1048.3238311289176;10975.50610222542;12641.810372844415;13091.541796037092;13327.466901324033;13887.652808679864;511892;521984;526288;530871;533696;118078;120022;121534.3923280378;122276;125032;1257.5409975359112;1273.9299338536468;1306.8235788168665;1310.0567591334225;1310.3186343101725;20585.79414205839;20866.58266834685;21590.892045539673;21703.674444883025;21763.23828665989;56334.7183264081;57861.4213857856;58117.70941145267;59918;60207.69896150491;78217;79709;80559.19440805752;81305.59347203225;81459.18540814753;20271.29050483226;21516;21540.522839873614;21657.241996530047;21719.239826605994;24089.397765055313;25088.247352579452;25139.74860251374;25282.87358563269;25394.365140871625;19306.7103993443;19447.70828437546;19487.415377538695;19783;19861.404157875288;16261.756073658667;16564.503064908073;17084.914575427043;17326.39357622477;17492.562685932953;19900.203991840743;19999.100040498502;20043;20055.0975206119;20061.899690501454;20468;20770.376888693365;21098;21246.25638102659;21352;17696.91151544234;18374.724379134055;18506.537336566693;18696.906515467337;19239.615207696046 16:31:52 INFO - PID 32560 | |3;mootools.html;1329.9667508312293;1358.3344161360935;1379.2414172205285;1386.5216500307397;1398.0912406935497;12981.805272920901;13358.66603334917;13426.865731342696;13442.596722098328;13471.461141554351;14337.498187563437;14550.345234464448;14595.197264150467;14609.269536523185;14703.852961470382;2396.3290278721897;2543.745625437455;2591.8704064796684;2592.2482480080753;2599.6620439342955;2561.8462892226526;2598.090668266101;2599.7010343810516;2600.4929038837436;2600.596907479344;2492.0903870087377;2513.258588716333;2524.936876578082;2534.771870531652;2590.5984572391308;2458.323960910746;2463.1502131764514;2491.676082109332;2493.0277191895266;2513;2482.7765501104986;2483.1060818105466;2499.0503608628605;2511.3219430753593;2518.445941892799;13737;13746.587602371945;13750.65623359414;13874.791878121836;13883.097598656155;7392.223816499298;7500.28747269014;7546.867969804518;7548.73579424723;7550.433717471212;4607.539246075399;4774.355462012619;4781.282807578891;4851.805927762885;4877.317175595419;1733.826617338256;1747.8077411484726;1749.7637818894414;1780.4450613369856;1791.570023194424;22838.771612283832;23132.53734925292;23143.652845207336;23148;23156.18953336625;6452.516061295421;6495.675216239264;6512.6092434454085;6648.7340506379205;6680.498962577826;15841.52475425739;15877.364905403885;15910.840891590937;15920.52238432849;15972.600684982968;7512.887306690404;7637.770866874002;7650;7653.0816302042995;7661.61691915402;6974.965125174342;7053.0125782390505;7137.607431591208;7162.283771622796;7178.102737157856;4785.569298763128;4994.303076338809;4999.550040496373;5067.417247016567;5071.467495912876;1526.96182595436;1536.761801920704;1548.99225503874;1576.8975016623883;1580.217792192849;798.22572105058;802.895623568944;808.272554700774;809.0897740042452;832.8667413213977;5821.621594596338;6218.409251121137;6269.623822570569;6286.151369565142;6963.268856770068;929.1359036096495;963.4026903319987;983.2772911909741;994.2940512236394;1001.2890847498212;3977.423273625308;4310.590493903074;4311.159323931804;4358.847440339573;4421.425214722066;18443.63112737738;18692.719609205873;18772.812271877105;18781.342653007352;19111.522211944535;17920.91039544794;18511.90744046298;18576.721349179774;19166.71249931224;19282.421527354203;10520.158387328995;10657.573697052187;10709.78580428387;10716.785664286826;10723.83914241287;6830.521863469509;7176.354128128493;7181.886807544839;7202.71189152428;7295;15202.619934501727;16171;16646.58504027171;17001.234944427284;17064.74402883933;16499;16703.749443758596;17103.144842757563;17325.393611223546;17475;13020.544280950122;13206.933965330112;13215.537456188988;13220.47118115303;13225.537106201236;13296.601101966957;13766.174029558259;13772.793408098687;13791.793123102962;13795.310234488035;9708.951455242679;10107.54516046765;10247.077763001365;10587.100096491884;10591.311564748266;9317.301202409712;9843.966383529627;9901.55443005052;9930.503474826086;10002.799944000933;8481.27909127731;8590.055093939787;8596;8602.569871506525;8619.094995025684;6199.721012554536;6317.431431171217;6432.421082102634;6434.581752186093;6462.838429039123;5924.585279030426;6054.39456054391;6088.607842753285;6281.9948808190475;6364.649944252926 16:31:52 INFO - PID 32560 | |4;prototype.html;495.4043445400687;499.73053745529364;512.5105524224366;517.6919732759008;523.3797949429924;6009.849753756158;6055.5761096723245;6112.7860524881635;6179.196704428429;6196.442320191182;5908.350081491043;5936.684692969745;5998.160257563934;6011.368806275344;6054.970654988651;4841.8063277468855;4844.588210002136;4862.197737373347;4876.1954277544255;4884.997151168021;4866.099771542258;4881.975590122044;4882.2432522959;4924.482929292427;4945.307656928015;4688.812447502113;4826.396700412449;4839.177339852216;4866.46468888422;4923.704577725348;4899.142650036247;4918.139325618003;4933;4934.185859333205;4940.876478088041;4353.869383918487;4376.6498680105515;4413.29387298034;4417.293233082723;4443.666724995606;5989.460948514655;6001.609895356788;6006.639601623917;6028.909566356509;6029.668368239745;5659.971700141514;5664.518515926151;5678.6024978251535;5697.116946873241;5700.942990570083;6401.551891367606;6422.389872962061;6456.386643268882;6473.223213214397;6535.346465353474;4773.355596994431;4791.664583479123;4803.663743537953;4808.182608956486;4832.64685887952;6788.5926844389005;6871.8317885959505;6879.6560171991205;6916.861662766767;6917.896231556581;4937.308776771255;4951.8266860659705;4980.726060066659;5001.149804533238;5007.195970256668;5029.5221953914315;5044.175261853374;5049.419316778544;5052.343195384577;5062.82280120194;5657.557322882721;5668.675842904472;5673;5674.886502269931;5691.886162276731;6479.153441269215;6502.837429064311;6535.921572940507;6627.9337206627315;6646.534742567974;1656.8591669707969;1695.9491215263563;1714.691355555987;1721.7589537464764;1739.8434140927377;1148.3224897310627;1169.216624861345;1198.9520419183134;1223.2110288863632;1225.6139316115396;5664.85837854057;5680.289963754531;5698.572607054488;5707.486326230659;5743.167240750151;6555.6066636002;6563.8359041023405;6586.27550969393;6587.374199451045;6588.571742836701;5554.472325129106;5636.154576813429;5646.887062258732;5699.202111704365;5714.79998200061;3484.3205574913154;3492.5808902931813;3500.649935006479;3504.7897126172;3523.647635236507;6455.548111632234;6455.935440645628;6457.3865482779065;6461.838454038592;6471.482281417475;6773.356531129535;6781.728730850711;6821.283765204681;6824.464495488475;6859.451243900476;6502.5211511840935;6508.088867558546;6531.150950376421;6534;6547;6514.73941042353;6556.246031706415;6588.374104460068;6651.767188148391;6689.632070236184;6454.290028097;6510.869782604416;6556.967215163893;6578.480512925562;6590.901136483052;6407.679616019273;6430.292667806444;6447.6131432114225;6462.676866156768;6482.837929051811;4863.440704319049;4878.1950978089635;4891.241857512091;4891.63312751538;4941.332920055746;6431.260405053479;6549.279579246184;6555.967220163869;6652.467802575686;6663.967085101817;6431.614103153825;6455.741770329134;6460.806175814733;6479.416852483299;6487.675616219264;6400.583962042639;6402.167718196604;6406.711697973696;6408.93591064102;6453.193350831146;6346.587471814318;6365.363463653783;6409.9359006411205;6424.10062591247;6473.935260647521;6238.721062182332;6281.59169653971;6322.956712142445;6405.583637063576;6423.871522569616;6113.327533971348;6174.25908890936;6200.131981522501;6212.968935155295;6218.347073557392 16:31:52 INFO - PID 32560 | |5;yui.html;885.3581153663595;907.2379201470764;908.5184852028424;913.6710784117716;915.0986278515661;17789;18704.43886683398;18717;18722.812771872294;18895.43313700588;20534.794652053475;21290.57418851622;21305.25431609894;21382.144714211452;21424;990.5245482168582;1052.9947350263237;1053.6522947427331;1055.166418529361;1055.5461151704765;1013.8594081658134;1057.9576816927313;1061.2359101446984;1064.5528877871313;1066.168388656849;1095.8794532601407;1103.2497901427028;1103.9677901162438;1109.589451902797;1115.5816568786704;1102.1348241630321;1109.5506319940437;1110.0619976120165;1110.4614262082882;1111.3387534417009;805.0862271322034;808.7169490678274;809.9473534220316;811.2455416462687;811.3914564076942;19281.807181928143;19344.70982935257;19365.80634193668;19445;20169.899150504152;20482.38552843417;20578.38264852057;20689.5862082759;21003.264885728928;21009.474763130893;15112.093274403462;15298.923505382512;15379.384824607003;15412.22938853064;15450.99568528042;3442.7245820334315;3477.0611934777467;3478.0261526772542;3482.251315967054;3485.599156097056;115877.42061289724;118054;118838;124165.37917310446;126314.3684281582;14815.481458149128;15214.087154770748;15217.847821521864;15221.543353699406;15239.390424383122;25842.35394115162;28950.565741513896;29227.853860730986;29282.853585731937;29451.41097178087;7818.452708310478;8107.473014254055;8116.2695357418115;8203.138670439637;8279.461834980708;3581.122624956902;3669.229461813049;3761.097336639187;3929.5088113985753;3945.822437990297;4997.450280469146;5120.692758434506;5239.895202095937;5243.606729495303;5260.500252476008;958.4249450329746;977.0961860279356;984.4290311619244;984.886738025122;986.1420564109271;622.790857352853;642.2357394700292;667.2660073918747;685.2701872505766;691.8443350246155;11363.37501437429;11660.475278612483;11812.70468238301;11971.820422693667;12127.514899404101;666.7233098264167;667.1893649216129;671.5467059734659;683.436165163732;707.3704403081261;4954.653174277766;5141.177411614124;5168.147255702767;5202.375714914235;5400.405955344909;92811.53594231985;98339.01660983442;100482;102738;103035.48482257691;86451;90890.54554727317;92047.53976230076;93199.53400232956;93665.5316723412;75522.62238688882;79217;80827.5958620215;82183.58908205421;82418;9666;9908.900910990798;10099.495025248561;10129.64546240878;10298;34904;35903.820480897426;35942.640573593926;37129;37921.4311785329;45714.31428528641;45807.312890306006;46024.76987615041;46781;48346.307879224056;15090.924545377204;15260.389584416498;15341.156236407105;15381.461648842236;15415.537533874001;17335.046572438638;17388.652226955644;17411.47765567035;17444.30222791125;17533.386331478338;15143.848561514244;15150.090994540364;15343.539693809204;15345.386184552493;15388.615284617526;15955.282012309242;16110.113943732738;16122.838771612134;16146;16277.755833662268;14743.041702289316;14916.25418729081;14939.477118301242;15056.849431505545;15084.094954302776;11283.605073822377;11899.013830366925;12091.455884485395;12225.388730563614;12311.753764924471;11972.940135299268;12054.819177712518;12337.259764414164;12578.874211258137;14419.206943618201 16:31:52 INFO - PID 32560 | __end_tp_report 16:31:52 INFO - PID 32560 | __start_cc_report 16:31:52 INFO - PID 32560 | _x_x_mozilla_cycle_collect,363 16:31:52 INFO - PID 32560 | __end_cc_report 16:31:52 INFO - PID 32560 | __startTimestamp1501198312715__endTimestamp 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | ------- Summary: start ------- 16:31:52 INFO - PID 32560 | Number of tests: 6 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | [#0] dojo.html Cycles:165 Average:6154.24 Median:6430.06 stddev:737.54 (11.5%) stddev-sans-first:699.49 16:31:52 INFO - PID 32560 | Values: 3088.4 3108.8 3137.8 3165.3 3187.6 6037.9 6258.3 6260.7 6266.1 6272.0 6045.3 6161.0 6171.9 6219.4 6236.3 5686.4 5691.8 5711.2 5731.3 5738.3 5752.1 5752.5 5755.1 5756.5 5772.9 5686.4 5705.1 5736.1 5738.7 5792.6 5483.6 5706.2 5706.9 5783.2 5792.8 5616.8 5628.3 5661.5 5719.8 5728.9 6028.7 6077.5 6102.3 6160.8 6213.5 6543.3 6607.3 6640.7 6709.1 6721.5 6756.5 6792.8 6816.5 6822.8 6827.0 6277.1 6278.0 6284.0 6284.5 6288.5 6883.6 6885.7 6919.7 6956.1 6957.9 6461.5 6485.5 6537.5 6559.8 6563.2 6611.1 6614.3 6622.4 6633.9 6711.4 6616.2 6657.6 6710.9 6718.8 6725.2 6684.7 6685.8 6706.7 6777.3 6778.8 5195.5 5254.0 5296.9 5301.8 5393.2 4578.1 4606.7 4625.6 4634.2 4639.8 5734.9 5806.3 5823.5 5855.3 5859.5 6638.0 6681.1 6682.8 6748.3 6775.3 5704.5 5785.6 5791.2 5878.2 5879.4 5900.8 5917.5 5924.0 5924.1 5927.7 6445.1 6517.4 6541.9 6557.4 6584.6 6602.3 6637.3 6689.1 6708.7 6735.4 6366.6 6463.9 6472.1 6556.3 6571.5 6531.0 6584.4 6618.7 6635.0 6643.9 6707.1 6754.3 6802.8 6808.4 6818.2 6510.1 6586.7 6601.8 6608.3 6615.3 6477.4 6483.1 6577.6 6583.4 6588.4 6332.7 6430.1 6437.3 6457.0 6457.7 6509.3 6523.3 6538.0 6615.4 6674.4 6219.1 6284.7 6316.2 6357.2 6398.3 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | [#1] ext.html Cycles:180 Average:39096.53 Median:36658.23 stddev:53295.37 (145.4%) stddev-sans-first:53367.39 16:31:52 INFO - PID 32560 | Values: 821.8 846.8 869.7 870.0 1185.0 32056.8 42640.8 43352.8 43422.6 43452.6 43723.0 43861.8 43916.6 44026.3 44207.1 7803.8 7954.2 7963.5 7974.0 7976.1 7722.9 7777.6 7789.3 7799.0 7840.5 7778.0 7833.4 7894.4 7962.8 7977.3 7826.4 7890.9 7896.2 7916.3 7953.5 7568.2 7795.3 7847.6 7924.0 7925.8 39714.0 40057.0 40116.2 40200.0 40203.0 3545.2 3557.0 3597.5 3598.8 3599.7 31633.7 31859.8 31963.4 32163.7 32222.4 4779.9 4801.4 4808.9 4837.4 4886.4 186320.0 187253.0 187526.0 187803.0 188142.0 48722.0 48894.5 48929.3 48961.5 49012.0 51441.5 51494.7 51596.5 51646.2 51932.0 17248.7 17294.7 17297.9 17368.0 17368.3 14113.6 14160.0 14183.9 14195.6 14195.6 13032.7 14237.9 14444.6 14612.6 14711.2 5009.5 6033.2 6349.8 6381.9 6400.6 982.0 982.0 997.3 1009.8 1016.1 23188.9 23397.9 23428.4 23752.9 23971.6 1075.2 1105.0 1110.4 1112.6 1113.4 11879.3 12382.9 15899.9 16124.6 16269.9 230047.0 231626.0 231752.0 231762.0 232714.0 58331.0 58398.4 58567.0 58623.7 58768.4 1460.6 1493.3 1493.5 1505.3 1508.4 26894.5 27669.0 27691.0 27696.6 27872.4 53817.0 54612.7 54654.2 54655.0 54659.7 194755.0 194793.0 195317.0 196979.0 197125.0 36143.5 36236.0 36506.6 36809.8 36885.1 41526.8 45574.5 45630.5 46760.8 47463.8 32315.2 32831.7 32903.3 33092.3 33463.0 29758.9 30892.7 32223.0 32601.7 32622.3 37147.6 39601.2 39633.8 39911.4 40092.0 33726.5 34466.3 34688.7 34989.8 44109.6 29688.9 29716.0 30746.0 30927.7 31341.5 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | [#2] jquery.html Cycles:180 Average:37700.88 Median:21741.24 stddev:87891.32 (404.3%) stddev-sans-first:88093.66 16:31:52 INFO - PID 32560 | Values: 569.4 571.2 575.3 580.6 588.6 21716.1 22469.2 22764.7 22803.4 23624.8 24807.0 25438.2 25458.0 25471.0 25775.6 6407.3 6537.8 6538.3 6544.6 6550.8 5948.6 6246.7 6466.5 6540.4 6555.9 6507.4 6518.0 6523.7 6526.9 6527.1 6465.4 6473.5 6485.2 6505.9 6520.1 6067.7 6074.1 6074.9 6076.8 6078.3 28442.9 29012.3 31291.0 32577.0 32644.3 1865.1 1901.6 1911.1 1912.3 1912.3 19617.0 20496.4 20618.0 20820.8 20855.3 2389.8 2447.4 2485.6 2489.0 2581.0 131181.0 133349.0 133366.3 135604.3 138586.6 20974.7 21639.0 21654.9 22266.4 22417.9 42968.1 42989.4 43197.0 43291.0 43369.3 11913.8 12072.8 12163.5 12197.6 12359.9 9944.3 10087.1 10087.5 10155.6 10335.1 9544.3 10770.2 11161.4 11680.5 11707.1 3646.6 3716.5 3727.4 4209.6 4253.1 937.7 948.5 971.4 971.9 973.0 19299.0 19479.8 19690.8 19839.2 20018.4 1002.2 1008.6 1027.5 1029.0 1048.3 10975.5 12641.8 13091.5 13327.5 13887.7 511892.0 521984.0 526288.0 530871.0 533696.0 118078.0 120022.0 121534.4 122276.0 125032.0 1257.5 1273.9 1306.8 1310.1 1310.3 20585.8 20866.6 21590.9 21703.7 21763.2 56334.7 57861.4 58117.7 59918.0 60207.7 78217.0 79709.0 80559.2 81305.6 81459.2 20271.3 21516.0 21540.5 21657.2 21719.2 24089.4 25088.2 25139.7 25282.9 25394.4 19306.7 19447.7 19487.4 19783.0 19861.4 16261.8 16564.5 17084.9 17326.4 17492.6 19900.2 19999.1 20043.0 20055.1 20061.9 20468.0 20770.4 21098.0 21246.3 21352.0 17696.9 18374.7 18506.5 18696.9 19239.6 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | [#3] mootools.html Cycles:180 Average:8489.89 Median:2512.16 stddev:5947.95 (236.8%) stddev-sans-first:5940.30 16:31:52 INFO - PID 32560 | Values: 1330.0 1358.3 1379.2 1386.5 1398.1 12981.8 13358.7 13426.9 13442.6 13471.5 14337.5 14550.3 14595.2 14609.3 14703.9 2396.3 2543.7 2591.9 2592.2 2599.7 2561.8 2598.1 2599.7 2600.5 2600.6 2492.1 2513.3 2524.9 2534.8 2590.6 2458.3 2463.2 2491.7 2493.0 2513.0 2482.8 2483.1 2499.1 2511.3 2518.4 13737.0 13746.6 13750.7 13874.8 13883.1 7392.2 7500.3 7546.9 7548.7 7550.4 4607.5 4774.4 4781.3 4851.8 4877.3 1733.8 1747.8 1749.8 1780.4 1791.6 22838.8 23132.5 23143.7 23148.0 23156.2 6452.5 6495.7 6512.6 6648.7 6680.5 15841.5 15877.4 15910.8 15920.5 15972.6 7512.9 7637.8 7650.0 7653.1 7661.6 6975.0 7053.0 7137.6 7162.3 7178.1 4785.6 4994.3 4999.6 5067.4 5071.5 1527.0 1536.8 1549.0 1576.9 1580.2 798.2 802.9 808.3 809.1 832.9 5821.6 6218.4 6269.6 6286.2 6963.3 929.1 963.4 983.3 994.3 1001.3 3977.4 4310.6 4311.2 4358.8 4421.4 18443.6 18692.7 18772.8 18781.3 19111.5 17920.9 18511.9 18576.7 19166.7 19282.4 10520.2 10657.6 10709.8 10716.8 10723.8 6830.5 7176.4 7181.9 7202.7 7295.0 15202.6 16171.0 16646.6 17001.2 17064.7 16499.0 16703.7 17103.1 17325.4 17475.0 13020.5 13206.9 13215.5 13220.5 13225.5 13296.6 13766.2 13772.8 13791.8 13795.3 9709.0 10107.5 10247.1 10587.1 10591.3 9317.3 9844.0 9901.6 9930.5 10002.8 8481.3 8590.1 8596.0 8602.6 8619.1 6199.7 6317.4 6432.4 6434.6 6462.8 5924.6 6054.4 6088.6 6282.0 6364.6 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | [#4] prototype.html Cycles:180 Average:5432.53 Median:6008.24 stddev:1528.82 (25.4%) stddev-sans-first:1487.52 16:31:52 INFO - PID 32560 | Values: 495.4 499.7 512.5 517.7 523.4 6009.8 6055.6 6112.8 6179.2 6196.4 5908.4 5936.7 5998.2 6011.4 6055.0 4841.8 4844.6 4862.2 4876.2 4885.0 4866.1 4882.0 4882.2 4924.5 4945.3 4688.8 4826.4 4839.2 4866.5 4923.7 4899.1 4918.1 4933.0 4934.2 4940.9 4353.9 4376.6 4413.3 4417.3 4443.7 5989.5 6001.6 6006.6 6028.9 6029.7 5660.0 5664.5 5678.6 5697.1 5700.9 6401.6 6422.4 6456.4 6473.2 6535.3 4773.4 4791.7 4803.7 4808.2 4832.6 6788.6 6871.8 6879.7 6916.9 6917.9 4937.3 4951.8 4980.7 5001.1 5007.2 5029.5 5044.2 5049.4 5052.3 5062.8 5657.6 5668.7 5673.0 5674.9 5691.9 6479.2 6502.8 6535.9 6627.9 6646.5 1656.9 1695.9 1714.7 1721.8 1739.8 1148.3 1169.2 1199.0 1223.2 1225.6 5664.9 5680.3 5698.6 5707.5 5743.2 6555.6 6563.8 6586.3 6587.4 6588.6 5554.5 5636.2 5646.9 5699.2 5714.8 3484.3 3492.6 3500.6 3504.8 3523.6 6455.5 6455.9 6457.4 6461.8 6471.5 6773.4 6781.7 6821.3 6824.5 6859.5 6502.5 6508.1 6531.2 6534.0 6547.0 6514.7 6556.2 6588.4 6651.8 6689.6 6454.3 6510.9 6557.0 6578.5 6590.9 6407.7 6430.3 6447.6 6462.7 6482.8 4863.4 4878.2 4891.2 4891.6 4941.3 6431.3 6549.3 6556.0 6652.5 6664.0 6431.6 6455.7 6460.8 6479.4 6487.7 6400.6 6402.2 6406.7 6408.9 6453.2 6346.6 6365.4 6409.9 6424.1 6473.9 6238.7 6281.6 6323.0 6405.6 6423.9 6113.3 6174.3 6200.1 6213.0 6218.3 16:31:52 INFO - PID 32560 | 16:31:52 INFO - PID 32560 | [#5] yui.html Cycles:180 Average:21469.81 Median:20508.59 stddev:29408.50 (143.4%) stddev-sans-first:29450.38 16:31:52 INFO - PID 32560 | Values: 885.4 907.2 908.5 913.7 915.1 17789.0 18704.4 18717.0 18722.8 18895.4 20534.8 21290.6 21305.3 21382.1 21424.0 990.5 1053.0 1053.7 1055.2 1055.5 1013.9 1058.0 1061.2 1064.6 1066.2 1095.9 1103.2 1104.0 1109.6 1115.6 1102.1 1109.6 1110.1 1110.5 1111.3 805.1 808.7 809.9 811.2 811.4 19281.8 19344.7 19365.8 19445.0 20169.9 20482.4 20578.4 20689.6 21003.3 21009.5 15112.1 15298.9 15379.4 15412.2 15451.0 3442.7 3477.1 3478.0 3482.3 3485.6 115877.4 118054.0 118838.0 124165.4 126314.4 14815.5 15214.1 15217.8 15221.5 15239.4 25842.4 28950.6 29227.9 29282.9 29451.4 7818.5 8107.5 8116.3 8203.1 8279.5 3581.1 3669.2 3761.1 3929.5 3945.8 4997.5 5120.7 5239.9 5243.6 5260.5 958.4 977.1 984.4 984.9 986.1 622.8 642.2 667.3 685.3 691.8 11363.4 11660.5 11812.7 11971.8 12127.5 666.7 667.2 671.5 683.4 707.4 4954.7 5141.2 5168.1 5202.4 5400.4 92811.5 98339.0 100482.0 102738.0 103035.5 86451.0 90890.5 92047.5 93199.5 93665.5 75522.6 79217.0 80827.6 82183.6 82418.0 9666.0 9908.9 10099.5 10129.6 10298.0 34904.0 35903.8 35942.6 37129.0 37921.4 45714.3 45807.3 46024.8 46781.0 48346.3 15090.9 15260.4 15341.2 15381.5 15415.5 17335.0 17388.7 17411.5 17444.3 17533.4 15143.8 15150.1 15343.5 15345.4 15388.6 15955.3 16110.1 16122.8 16146.0 16277.8 14743.0 14916.3 14939.5 15056.8 15084.1 11283.6 11899.0 12091.5 12225.4 12311.8 11972.9 12054.8 12337.3 12578.9 14419.2 16:31:52 INFO - PID 32560 | -------- Summary: end -------- 16:31:52 INFO - PID 32560 | 16:31:53 INFO - TEST-INFO | 32560: exit 0 16:31:53 INFO - TEST-OK | dromaeo_css | took 1113531ms 16:31:53 INFO - TEST-START | kraken 16:31:53 INFO - Initialising browser for kraken test... 16:31:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34585/getInfo.html -profile /tmp/tmpLutkwF/profile 16:31:53 INFO - TEST-INFO | started process 465 (/builds/slave/test/build/application/firefox/firefox http://localhost:34585/getInfo.html) 16:31:59 INFO - TEST-INFO | 465: exit 0 16:31:59 INFO - Browser initialized. 16:31:59 INFO - Running cycle 1/1 for kraken test... 16:31:59 INFO - TEST-INFO | started process 694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLutkwF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:00 INFO - PID 694 | 16:32:00 INFO - PID 694 | (/builds/slave/test/build/application/firefox/firefox:750): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:32:00 INFO - PID 694 | 16:32:10 INFO - PID 694 | RSS: Main: 173510656 16:32:10 INFO - PID 694 | 16:32:13 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34585/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:14 INFO - PID 694 | RSS: Main: 178638848 16:32:14 INFO - PID 694 | 16:32:17 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34585/tests/kraken/driver.html?testName=audio-dft) 16:32:18 INFO - PID 694 | RSS: Main: 178667520 16:32:18 INFO - PID 694 | 16:32:21 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34585/tests/kraken/driver.html?testName=audio-fft) 16:32:21 INFO - PID 694 | RSS: Main: 173629440 16:32:21 INFO - PID 694 | 16:32:23 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34585/tests/kraken/driver.html?testName=audio-oscillator) 16:32:24 INFO - PID 694 | RSS: Main: 174071808 16:32:24 INFO - PID 694 | 16:32:26 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:27 INFO - PID 694 | RSS: Main: 174424064 16:32:27 INFO - PID 694 | 16:32:30 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34585/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:31 INFO - PID 694 | RSS: Main: 176820224 16:32:31 INFO - PID 694 | 16:32:34 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34585/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:35 INFO - PID 694 | RSS: Main: 175759360 16:32:35 INFO - PID 694 | 16:32:38 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34585/tests/kraken/driver.html?testName=json-parse-financial) 16:32:38 INFO - PID 694 | RSS: Main: 177262592 16:32:38 INFO - PID 694 | 16:32:40 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:41 INFO - PID 694 | RSS: Main: 177238016 16:32:41 INFO - PID 694 | 16:32:43 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:43 INFO - PID 694 | RSS: Main: 174194688 16:32:43 INFO - PID 694 | 16:32:46 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:46 INFO - PID 694 | RSS: Main: 174596096 16:32:46 INFO - PID 694 | 16:32:49 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:50 INFO - PID 694 | RSS: Main: 175042560 16:32:50 INFO - PID 694 | 16:32:53 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:53 INFO - PID 694 | RSS: Main: 175108096 16:32:53 INFO - PID 694 | 16:32:55 INFO - PID 694 | Cycle 1(1): loaded http://localhost:34585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34585/tests/kraken/driver.html?testName=ai-astar) 16:32:56 INFO - PID 694 | RSS: Main: 176713728 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | __start_tp_report 16:32:56 INFO - PID 694 | _x_x_mozilla_page_load 16:32:56 INFO - PID 694 | _x_x_mozilla_page_load_details 16:32:56 INFO - PID 694 | |i|pagename|runs| 16:32:56 INFO - PID 694 | |0;ai-astar;100;112;103;109;109;116;110;102;111;112 16:32:56 INFO - PID 694 | |1;audio-beat-detection;147;116;147;182;119;143;147;133;180;136 16:32:56 INFO - PID 694 | |2;audio-dft;163;163;164;163;168;169;175;165;163;166 16:32:56 INFO - PID 694 | |3;audio-fft;75;76;75;174;75;75;76;81;160;78 16:32:56 INFO - PID 694 | |4;audio-oscillator;79;80;140;79;79;79;134;78;87;128 16:32:56 INFO - PID 694 | |5;imaging-gaussian-blur;114;114;114;116;115;114;113;117;114;120 16:32:56 INFO - PID 694 | |6;imaging-darkroom;151;153;151;151;152;150;151;151;150;152 16:32:56 INFO - PID 694 | |7;imaging-desaturate;94;94;99;95;95;94;94;94;94;94 16:32:56 INFO - PID 694 | |8;json-parse-financial;57;55;57;57;61;60;60;64;57;58 16:32:56 INFO - PID 694 | |9;json-stringify-tinderbox;58;54;65;54;58;54;53;56;59;57 16:32:56 INFO - PID 694 | |10;stanford-crypto-aes;84;88;87;92;89;83;81;90;90;81 16:32:56 INFO - PID 694 | |11;stanford-crypto-ccm;130;135;128;133;124;126;143;127;124;165 16:32:56 INFO - PID 694 | |12;stanford-crypto-pbkdf2;189;185;176;182;179;192;180;176;185;184 16:32:56 INFO - PID 694 | |13;stanford-crypto-sha256-iterative;71;74;69;70;67;75;84;71;70;73 16:32:56 INFO - PID 694 | __end_tp_report 16:32:56 INFO - PID 694 | __start_cc_report 16:32:56 INFO - PID 694 | _x_x_mozilla_cycle_collect,970 16:32:56 INFO - PID 694 | __end_cc_report 16:32:56 INFO - PID 694 | __startTimestamp1501198376113__endTimestamp 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | ------- Summary: start ------- 16:32:56 INFO - PID 694 | Number of tests: 14 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:5.10 (4.6%) stddev-sans-first:4.42 16:32:56 INFO - PID 694 | Values: 100.0 112.0 103.0 109.0 109.0 116.0 110.0 102.0 111.0 112.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:147.00 stddev:21.99 (15.0%) stddev-sans-first:23.31 16:32:56 INFO - PID 694 | Values: 147.0 116.0 147.0 182.0 119.0 143.0 147.0 133.0 180.0 136.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:3.87 (2.3%) stddev-sans-first:3.96 16:32:56 INFO - PID 694 | Values: 163.0 163.0 164.0 163.0 168.0 169.0 175.0 165.0 163.0 166.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.50 stddev:38.40 (50.9%) stddev-sans-first:40.07 16:32:56 INFO - PID 694 | Values: 75.0 76.0 75.0 174.0 75.0 75.0 76.0 81.0 160.0 78.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:79.00 stddev:26.29 (33.3%) stddev-sans-first:27.13 16:32:56 INFO - PID 694 | Values: 79.0 80.0 140.0 79.0 79.0 79.0 134.0 78.0 87.0 128.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.50 stddev:2.08 (1.8%) stddev-sans-first:2.17 16:32:56 INFO - PID 694 | Values: 114.0 114.0 114.0 116.0 115.0 114.0 113.0 117.0 114.0 120.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 16:32:56 INFO - PID 694 | Values: 151.0 153.0 151.0 151.0 152.0 150.0 151.0 151.0 150.0 152.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 16:32:56 INFO - PID 694 | Values: 94.0 94.0 99.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:2.63 (4.5%) stddev-sans-first:2.73 16:32:56 INFO - PID 694 | Values: 57.0 55.0 57.0 57.0 61.0 60.0 60.0 64.0 57.0 58.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.50 stddev:3.55 (6.2%) stddev-sans-first:3.74 16:32:56 INFO - PID 694 | Values: 58.0 54.0 65.0 54.0 58.0 54.0 53.0 56.0 59.0 57.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:88.50 stddev:3.98 (4.5%) stddev-sans-first:4.12 16:32:56 INFO - PID 694 | Values: 84.0 88.0 87.0 92.0 89.0 83.0 81.0 90.0 90.0 81.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:131.50 stddev:12.50 (9.5%) stddev-sans-first:13.20 16:32:56 INFO - PID 694 | Values: 130.0 135.0 128.0 133.0 124.0 126.0 143.0 127.0 124.0 165.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:184.50 stddev:5.27 (2.9%) stddev-sans-first:5.09 16:32:56 INFO - PID 694 | Values: 189.0 185.0 176.0 182.0 179.0 192.0 180.0 176.0 185.0 184.0 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.00 stddev:4.72 (6.6%) stddev-sans-first:4.98 16:32:56 INFO - PID 694 | Values: 71.0 74.0 69.0 70.0 67.0 75.0 84.0 71.0 70.0 73.0 16:32:56 INFO - PID 694 | -------- Summary: end -------- 16:32:56 INFO - PID 694 | 16:32:56 INFO - PID 694 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:32:56 INFO - TEST-INFO | 694: exit 0 16:32:56 INFO - TEST-OK | kraken | took 63372ms 16:32:56 INFO - SUITE-END | took 1176s 16:32:57 INFO - Completed test suite (00:19:37) 16:32:57 INFO - javascript benchmark 16:32:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8507.723943126477, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.382323535292, 3108.7512998960087, 3137.764667649926, 3165.2561648012706, 3187.6015498062743, 6037.879242415154, 6258.311585725566, 6260.655663938482, 6266.122742816009, 6271.965125754256, 6045.304789949146, 6161.0, 6171.876562468748, 6219.440250377476, 6236.251649802019, 5686.431356864322, 5691.7723291068305, 5711.228984087136, 5731.340895796974, 5738.282714660668, 5752.079667253241, 5752.5110365618975, 5755.079187330028, 5756.539476841843, 5772.942270577303, 5686.3744988051285, 5705.087186050233, 5736.11090281005, 5738.684372359518, 5792.565557583198, 5483.561315094823, 5706.172604972297, 5706.9429305707245, 5783.190353350535, 5792.82621521355, 5616.803411880605, 5628.26832511775, 5661.46216109469, 5719.771209151629, 5728.914066289009, 6028.668423236721, 6077.483413909778, 6102.26772787264, 6160.84597885052, 6213.5339849511465, 6543.280239173687, 6607.306232845578, 6640.667966601651, 6709.09427227323, 6721.462283017347, 6756.527043106985, 6792.830179245509, 6816.522843400964, 6822.795316140524, 6827.044213810071, 6277.058441233806, 6278.0, 6283.963146080891, 6284.528660350446, 6288.52836037299, 6883.586984780929, 6885.724571017103, 6919.688614012382, 6956.060931774247, 6957.9304206958295, 6461.483081353481, 6485.4811615070685, 6537.509686773511, 6559.770408035696, 6563.245226798884, 6611.140551728245, 6614.272430032693, 6622.403983641495, 6633.900491492632, 6711.362420570038, 6616.206055273302, 6657.567258128303, 6710.932890671128, 6718.798436046926, 6725.159355080615, 6684.732610695518, 6685.832854178587, 6706.731730730814, 6777.288384719632, 6778.762743303961, 5195.532402083831, 5254.0, 5296.92054619181, 5301.840944771663, 5393.244945707525, 4578.107269082563, 4606.700564463366, 4625.560571745679, 4634.165850147006, 4639.791209395586, 5734.942650573441, 5806.303243610793, 5823.475887170175, 5855.326637436664, 5859.53123750099, 6638.0374845648075, 6681.064650948871, 6682.832929176712, 6748.325167483311, 6775.254721980578, 5704.543636509153, 5785.595008349375, 5791.247137872134, 5878.177055212273, 5879.412058794172, 5900.793472228452, 5917.497012753878, 5923.970380148072, 5924.081767326072, 5927.673977931169, 6445.097686323918, 6517.3808488193545, 6541.934580654228, 6557.377049180415, 6584.604923704593, 6602.306757790555, 6637.336266373517, 6689.09697190873, 6708.731650733916, 6735.393814556714, 6366.586171898812, 6463.935360646334, 6472.126262954629, 6556.2788093308745, 6571.507136964651, 6531.0, 6584.407403333723, 6618.735250590115, 6635.0, 6643.936970084763, 6707.128073350434, 6754.324567543206, 6802.761903333359, 6808.421284190701, 6818.249992500921, 6510.056041873996, 6586.736530538917, 6601.834954126185, 6608.306127856506, 6615.272320044887, 6477.4170324671, 6483.09236706852, 6577.572457790228, 6583.407493325623, 6588.374104460068, 6332.715027823667, 6430.061802736699, 6437.324080971618, 6457.031445283245, 6457.67711614408, 6509.349065093453, 6523.3150519194805, 6537.967310163609, 6615.37153970372, 6674.365935236145, 6219.067139929047, 6284.74861005573, 6316.242050953915, 6357.237131544244, 6398.328175541687], "value": 6098.021434723285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.7699044267607, 846.7840700621341, 869.6521391443422, 869.9869501957468, 1184.9881501184987, 32056.839715801416, 42640.786796066015, 43352.78323608385, 43422.565774342285, 43452.56547434525, 43723.0, 43861.7806910965, 43916.56083439165, 44026.33960490595, 44207.115857682904, 7803.7658870233845, 7954.16481269467, 7963.482373645724, 7974.0431148262, 7976.122626511079, 7722.884156737626, 7777.572233527154, 7789.298963093321, 7798.961005194995, 7840.529568225897, 7777.961110194441, 7833.41249406294, 7894.407919406039, 7962.840743185133, 7977.321927636158, 7826.413019023567, 7890.8816367754525, 7896.170902055288, 7916.287534121899, 7953.483023603448, 7568.205338439439, 7795.33739632132, 7847.607619618996, 7923.960380198062, 7925.7622271331375, 39714.0, 40057.0, 40116.197676046315, 40200.0, 40203.0, 3545.166885781839, 3556.964430355715, 3597.460380942853, 3598.7660802048044, 3599.748017638766, 31633.683663163305, 31859.84070079658, 31963.360732785215, 32163.678363216302, 32222.355552889047, 4779.856604301876, 4801.375821143264, 4808.879778005543, 4837.395325584302, 4886.438059623153, 186320.0, 187253.0, 187526.0, 187803.0, 188142.0, 48722.0, 48894.51105488899, 48929.26606100911, 48961.51038489569, 49012.0, 51441.485585143666, 51494.742526287126, 51596.48403515992, 51646.22530662043, 51932.0, 17248.741268880978, 17294.740578891327, 17297.91351043262, 17368.044757538457, 17368.305267789146, 14113.647158820906, 14160.0, 14183.85816141846, 14195.645108872155, 14195.64510887236, 13032.739345213042, 14237.857621423653, 14444.638884027983, 14612.561623151323, 14711.190884501455, 5009.522190953678, 6033.215681961317, 6349.809505714836, 6381.946978748548, 6400.55196136266, 981.9705408837747, 981.9852702209473, 997.2719914462483, 1009.848522721583, 1016.1362841584594, 23188.88405557995, 23397.88301058484, 23428.414289642897, 23752.88123559371, 23971.640425393634, 1075.2097208551866, 1104.9502772375263, 1110.4114819145866, 1112.5994641928899, 1113.3598181045932, 11879.290118064084, 12382.938085309515, 15899.920500397424, 16124.596885077966, 16269.918650406673, 230047.0, 231626.0, 231752.0, 231762.0, 232714.0, 58331.0, 58398.41601584015, 58567.0, 58623.706881466176, 58768.41231587715, 1460.5764328344874, 1493.320539154682, 1493.5370035288877, 1505.2548988250885, 1508.3891024135244, 26894.462110757286, 27669.0, 27691.0, 27696.584551231346, 27872.44255114927, 53817.0, 54612.72693636506, 54654.180187298014, 54655.0, 54659.72670136783, 194755.0, 194793.0, 195317.0, 196979.0, 197125.0, 36143.45784813177, 36236.0, 36506.634933650326, 36809.81595092007, 36885.077873053386, 41526.792366037975, 45574.54425455703, 45630.54369456396, 46760.7661961688, 47463.762681186374, 32315.19212019718, 32831.67168328286, 32903.34193316168, 33092.33815323632, 33463.0, 29758.85120574383, 30892.691073088983, 32223.0, 32601.673983259865, 32622.34755304833, 37147.62852371442, 39601.207975840895, 39633.80183099066, 39911.40132897951, 40092.0, 33726.49410258897, 34466.31067378689, 34688.65311346854, 34989.825050874584, 44109.55890441054, 29688.851555742083, 29716.0, 30746.0, 30927.69072309248, 31341.529877051405], "value": 18088.680973544986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3566270114769, 571.2488078177199, 575.2923903598572, 580.6371018113682, 588.632104934416, 21716.131354745812, 22469.21357752479, 22764.658530122062, 22803.429914252152, 23624.763752362473, 24807.0, 25438.236852894395, 25458.0, 25471.0, 25775.613365799527, 6407.263164736069, 6537.77117800877, 6538.280789113193, 6544.640044797558, 6550.770723024695, 5948.643081415107, 6246.656433896134, 6466.547341686084, 6540.37866402691, 6555.868882622344, 6507.381798729113, 6517.989711594711, 6523.7064332105165, 6526.934730652704, 6527.086207930894, 6465.418112369863, 6473.546851720382, 6485.2217733872, 6505.869882602345, 6520.0871877937125, 6067.666278354689, 6074.088886667036, 6074.936886044925, 6076.848078798022, 6078.270607527081, 28442.857785710938, 29012.27469313263, 31291.0, 32577.0, 32644.347113057607, 1865.0767869904348, 1901.5721462670926, 1911.0635788463692, 1912.2542208538541, 1912.3306842605116, 19617.0, 20496.38510844677, 20618.0, 20820.791792082036, 20855.270065547633, 2389.7968672662846, 2447.36368544178, 2485.5898776701824, 2489.041718938222, 2580.9612855807177, 131181.0, 133349.0, 133366.33316833354, 135604.3219783895, 138586.61413385838, 20974.685379719318, 21638.996785594714, 21654.942780436148, 22266.443338916655, 22417.887910560345, 42968.14063718708, 42989.35515967263, 43197.0, 43291.0, 43369.34945975813, 11913.761724765456, 12072.758544829054, 12163.452644631012, 12197.573084941985, 12359.938200309121, 9944.30389872702, 10087.142592879542, 10087.49562521871, 10155.644552440777, 10335.121514671187, 9544.33189676716, 10770.192235582363, 11161.386123763272, 11680.532778688757, 11707.121965852424, 3646.59606051672, 3716.479692843004, 3727.422249551324, 4209.642180414638, 4253.128108737701, 937.6811883959487, 948.4878165790396, 971.3686104032295, 971.868797712314, 972.9805403891883, 19299.0, 19479.8052019478, 19690.803091968897, 19839.206431742856, 20018.399448016582, 1002.1982414068716, 1008.5713571731984, 1027.4605831938143, 1028.9588416463257, 1048.3238311289176, 10975.50610222542, 12641.810372844415, 13091.541796037092, 13327.466901324033, 13887.652808679864, 511892.0, 521984.0, 526288.0, 530871.0, 533696.0, 118078.0, 120022.0, 121534.3923280378, 122276.0, 125032.0, 1257.5409975359112, 1273.9299338536468, 1306.8235788168665, 1310.0567591334225, 1310.3186343101725, 20585.79414205839, 20866.58266834685, 21590.892045539673, 21703.674444883025, 21763.23828665989, 56334.7183264081, 57861.4213857856, 58117.70941145267, 59918.0, 60207.69896150491, 78217.0, 79709.0, 80559.19440805752, 81305.59347203225, 81459.18540814753, 20271.29050483226, 21516.0, 21540.522839873614, 21657.241996530047, 21719.239826605994, 24089.397765055313, 25088.247352579452, 25139.74860251374, 25282.87358563269, 25394.365140871625, 19306.7103993443, 19447.70828437546, 19487.415377538695, 19783.0, 19861.404157875288, 16261.756073658667, 16564.503064908073, 17084.914575427043, 17326.39357622477, 17492.562685932953, 19900.203991840743, 19999.100040498502, 20043.0, 20055.0975206119, 20061.899690501454, 20468.0, 20770.376888693365, 21098.0, 21246.25638102659, 21352.0, 17696.91151544234, 18374.724379134055, 18506.537336566693, 18696.906515467337, 19239.615207696046], "value": 13160.537115816045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.9667508312293, 1358.3344161360935, 1379.2414172205285, 1386.5216500307397, 1398.0912406935497, 12981.805272920901, 13358.66603334917, 13426.865731342696, 13442.596722098328, 13471.461141554351, 14337.498187563437, 14550.345234464448, 14595.197264150467, 14609.269536523185, 14703.852961470382, 2396.3290278721897, 2543.745625437455, 2591.8704064796684, 2592.2482480080753, 2599.6620439342955, 2561.8462892226526, 2598.090668266101, 2599.7010343810516, 2600.4929038837436, 2600.596907479344, 2492.0903870087377, 2513.258588716333, 2524.936876578082, 2534.771870531652, 2590.5984572391308, 2458.323960910746, 2463.1502131764514, 2491.676082109332, 2493.0277191895266, 2513.0, 2482.7765501104986, 2483.1060818105466, 2499.0503608628605, 2511.3219430753593, 2518.445941892799, 13737.0, 13746.587602371945, 13750.65623359414, 13874.791878121836, 13883.097598656155, 7392.223816499298, 7500.28747269014, 7546.867969804518, 7548.73579424723, 7550.433717471212, 4607.539246075399, 4774.355462012619, 4781.282807578891, 4851.805927762885, 4877.317175595419, 1733.826617338256, 1747.8077411484726, 1749.7637818894414, 1780.4450613369856, 1791.570023194424, 22838.771612283832, 23132.53734925292, 23143.652845207336, 23148.0, 23156.18953336625, 6452.516061295421, 6495.675216239264, 6512.6092434454085, 6648.7340506379205, 6680.498962577826, 15841.52475425739, 15877.364905403885, 15910.840891590937, 15920.52238432849, 15972.600684982968, 7512.887306690404, 7637.770866874002, 7650.0, 7653.0816302042995, 7661.61691915402, 6974.965125174342, 7053.0125782390505, 7137.607431591208, 7162.283771622796, 7178.102737157856, 4785.569298763128, 4994.303076338809, 4999.550040496373, 5067.417247016567, 5071.467495912876, 1526.96182595436, 1536.761801920704, 1548.99225503874, 1576.8975016623883, 1580.217792192849, 798.22572105058, 802.895623568944, 808.272554700774, 809.0897740042452, 832.8667413213977, 5821.621594596338, 6218.409251121137, 6269.623822570569, 6286.151369565142, 6963.268856770068, 929.1359036096495, 963.4026903319987, 983.2772911909741, 994.2940512236394, 1001.2890847498212, 3977.423273625308, 4310.590493903074, 4311.159323931804, 4358.847440339573, 4421.425214722066, 18443.63112737738, 18692.719609205873, 18772.812271877105, 18781.342653007352, 19111.522211944535, 17920.91039544794, 18511.90744046298, 18576.721349179774, 19166.71249931224, 19282.421527354203, 10520.158387328995, 10657.573697052187, 10709.78580428387, 10716.785664286826, 10723.83914241287, 6830.521863469509, 7176.354128128493, 7181.886807544839, 7202.71189152428, 7295.0, 15202.619934501727, 16171.0, 16646.58504027171, 17001.234944427284, 17064.74402883933, 16499.0, 16703.749443758596, 17103.144842757563, 17325.393611223546, 17475.0, 13020.544280950122, 13206.933965330112, 13215.537456188988, 13220.47118115303, 13225.537106201236, 13296.601101966957, 13766.174029558259, 13772.793408098687, 13791.793123102962, 13795.310234488035, 9708.951455242679, 10107.54516046765, 10247.077763001365, 10587.100096491884, 10591.311564748266, 9317.301202409712, 9843.966383529627, 9901.55443005052, 9930.503474826086, 10002.799944000933, 8481.27909127731, 8590.055093939787, 8596.0, 8602.569871506525, 8619.094995025684, 6199.721012554536, 6317.431431171217, 6432.421082102634, 6434.581752186093, 6462.838429039123, 5924.585279030426, 6054.39456054391, 6088.607842753285, 6281.9948808190475, 6364.649944252926], "value": 6138.900209551689, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.4043445400687, 499.73053745529364, 512.5105524224366, 517.6919732759008, 523.3797949429924, 6009.849753756158, 6055.5761096723245, 6112.7860524881635, 6179.196704428429, 6196.442320191182, 5908.350081491043, 5936.684692969745, 5998.160257563934, 6011.368806275344, 6054.970654988651, 4841.8063277468855, 4844.588210002136, 4862.197737373347, 4876.1954277544255, 4884.997151168021, 4866.099771542258, 4881.975590122044, 4882.2432522959, 4924.482929292427, 4945.307656928015, 4688.812447502113, 4826.396700412449, 4839.177339852216, 4866.46468888422, 4923.704577725348, 4899.142650036247, 4918.139325618003, 4933.0, 4934.185859333205, 4940.876478088041, 4353.869383918487, 4376.6498680105515, 4413.29387298034, 4417.293233082723, 4443.666724995606, 5989.460948514655, 6001.609895356788, 6006.639601623917, 6028.909566356509, 6029.668368239745, 5659.971700141514, 5664.518515926151, 5678.6024978251535, 5697.116946873241, 5700.942990570083, 6401.551891367606, 6422.389872962061, 6456.386643268882, 6473.223213214397, 6535.346465353474, 4773.355596994431, 4791.664583479123, 4803.663743537953, 4808.182608956486, 4832.64685887952, 6788.5926844389005, 6871.8317885959505, 6879.6560171991205, 6916.861662766767, 6917.896231556581, 4937.308776771255, 4951.8266860659705, 4980.726060066659, 5001.149804533238, 5007.195970256668, 5029.5221953914315, 5044.175261853374, 5049.419316778544, 5052.343195384577, 5062.82280120194, 5657.557322882721, 5668.675842904472, 5673.0, 5674.886502269931, 5691.886162276731, 6479.153441269215, 6502.837429064311, 6535.921572940507, 6627.9337206627315, 6646.534742567974, 1656.8591669707969, 1695.9491215263563, 1714.691355555987, 1721.7589537464764, 1739.8434140927377, 1148.3224897310627, 1169.216624861345, 1198.9520419183134, 1223.2110288863632, 1225.6139316115396, 5664.85837854057, 5680.289963754531, 5698.572607054488, 5707.486326230659, 5743.167240750151, 6555.6066636002, 6563.8359041023405, 6586.27550969393, 6587.374199451045, 6588.571742836701, 5554.472325129106, 5636.154576813429, 5646.887062258732, 5699.202111704365, 5714.79998200061, 3484.3205574913154, 3492.5808902931813, 3500.649935006479, 3504.7897126172, 3523.647635236507, 6455.548111632234, 6455.935440645628, 6457.3865482779065, 6461.838454038592, 6471.482281417475, 6773.356531129535, 6781.728730850711, 6821.283765204681, 6824.464495488475, 6859.451243900476, 6502.5211511840935, 6508.088867558546, 6531.150950376421, 6534.0, 6547.0, 6514.73941042353, 6556.246031706415, 6588.374104460068, 6651.767188148391, 6689.632070236184, 6454.290028097, 6510.869782604416, 6556.967215163893, 6578.480512925562, 6590.901136483052, 6407.679616019273, 6430.292667806444, 6447.6131432114225, 6462.676866156768, 6482.837929051811, 4863.440704319049, 4878.1950978089635, 4891.241857512091, 4891.63312751538, 4941.332920055746, 6431.260405053479, 6549.279579246184, 6555.967220163869, 6652.467802575686, 6663.967085101817, 6431.614103153825, 6455.741770329134, 6460.806175814733, 6479.416852483299, 6487.675616219264, 6400.583962042639, 6402.167718196604, 6406.711697973696, 6408.93591064102, 6453.193350831146, 6346.587471814318, 6365.363463653783, 6409.9359006411205, 6424.10062591247, 6473.935260647521, 6238.721062182332, 6281.59169653971, 6322.956712142445, 6405.583637063576, 6423.871522569616, 6113.327533971348, 6174.25908890936, 6200.131981522501, 6212.968935155295, 6218.347073557392], "value": 4981.798778070347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.3581153663595, 907.2379201470764, 908.5184852028424, 913.6710784117716, 915.0986278515661, 17789.0, 18704.43886683398, 18717.0, 18722.812771872294, 18895.43313700588, 20534.794652053475, 21290.57418851622, 21305.25431609894, 21382.144714211452, 21424.0, 990.5245482168582, 1052.9947350263237, 1053.6522947427331, 1055.166418529361, 1055.5461151704765, 1013.8594081658134, 1057.9576816927313, 1061.2359101446984, 1064.5528877871313, 1066.168388656849, 1095.8794532601407, 1103.2497901427028, 1103.9677901162438, 1109.589451902797, 1115.5816568786704, 1102.1348241630321, 1109.5506319940437, 1110.0619976120165, 1110.4614262082882, 1111.3387534417009, 805.0862271322034, 808.7169490678274, 809.9473534220316, 811.2455416462687, 811.3914564076942, 19281.807181928143, 19344.70982935257, 19365.80634193668, 19445.0, 20169.899150504152, 20482.38552843417, 20578.38264852057, 20689.5862082759, 21003.264885728928, 21009.474763130893, 15112.093274403462, 15298.923505382512, 15379.384824607003, 15412.22938853064, 15450.99568528042, 3442.7245820334315, 3477.0611934777467, 3478.0261526772542, 3482.251315967054, 3485.599156097056, 115877.42061289724, 118054.0, 118838.0, 124165.37917310446, 126314.3684281582, 14815.481458149128, 15214.087154770748, 15217.847821521864, 15221.543353699406, 15239.390424383122, 25842.35394115162, 28950.565741513896, 29227.853860730986, 29282.853585731937, 29451.41097178087, 7818.452708310478, 8107.473014254055, 8116.2695357418115, 8203.138670439637, 8279.461834980708, 3581.122624956902, 3669.229461813049, 3761.097336639187, 3929.5088113985753, 3945.822437990297, 4997.450280469146, 5120.692758434506, 5239.895202095937, 5243.606729495303, 5260.500252476008, 958.4249450329746, 977.0961860279356, 984.4290311619244, 984.886738025122, 986.1420564109271, 622.790857352853, 642.2357394700292, 667.2660073918747, 685.2701872505766, 691.8443350246155, 11363.37501437429, 11660.475278612483, 11812.70468238301, 11971.820422693667, 12127.514899404101, 666.7233098264167, 667.1893649216129, 671.5467059734659, 683.436165163732, 707.3704403081261, 4954.653174277766, 5141.177411614124, 5168.147255702767, 5202.375714914235, 5400.405955344909, 92811.53594231985, 98339.01660983442, 100482.0, 102738.0, 103035.48482257691, 86451.0, 90890.54554727317, 92047.53976230076, 93199.53400232956, 93665.5316723412, 75522.62238688882, 79217.0, 80827.5958620215, 82183.58908205421, 82418.0, 9666.0, 9908.900910990798, 10099.495025248561, 10129.64546240878, 10298.0, 34904.0, 35903.820480897426, 35942.640573593926, 37129.0, 37921.4311785329, 45714.31428528641, 45807.312890306006, 46024.76987615041, 46781.0, 48346.307879224056, 15090.924545377204, 15260.389584416498, 15341.156236407105, 15381.461648842236, 15415.537533874001, 17335.046572438638, 17388.652226955644, 17411.47765567035, 17444.30222791125, 17533.386331478338, 15143.848561514244, 15150.090994540364, 15343.539693809204, 15345.386184552493, 15388.615284617526, 15955.282012309242, 16110.113943732738, 16122.838771612134, 16146.0, 16277.755833662268, 14743.041702289316, 14916.25418729081, 14939.477118301242, 15056.849431505545, 15084.094954302776, 11283.605073822377, 11899.013830366925, 12091.455884485395, 12225.388730563614, 12311.753764924471, 11972.940135299268, 12054.819177712518, 12337.259764414164, 12578.874211258137, 14419.206943618201], "value": 8540.89560926784, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 103.0, 109.0, 109.0, 116.0, 110.0, 102.0, 111.0, 112.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 147.0, 182.0, 119.0, 143.0, 147.0, 133.0, 180.0, 136.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 168.0, 169.0, 175.0, 165.0, 163.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 174.0, 75.0, 75.0, 76.0, 81.0, 160.0, 78.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 140.0, 79.0, 79.0, 79.0, 134.0, 78.0, 87.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 116.0, 115.0, 114.0, 113.0, 117.0, 114.0, 120.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 151.0, 151.0, 152.0, 150.0, 151.0, 151.0, 150.0, 152.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 57.0, 61.0, 60.0, 60.0, 64.0, 57.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 65.0, 54.0, 58.0, 54.0, 53.0, 56.0, 59.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 87.0, 92.0, 89.0, 83.0, 81.0, 90.0, 90.0, 81.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 128.0, 133.0, 124.0, 126.0, 143.0, 127.0, 124.0, 165.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 176.0, 182.0, 179.0, 192.0, 180.0, 176.0, 185.0, 184.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 69.0, 70.0, 67.0, 75.0, 84.0, 71.0, 70.0, 73.0], "value": 72.4, "unit": "score"}]}]} 16:32:57 INFO - Return code: 0 16:32:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:57 INFO - # TBPL SUCCESS # 16:32:57 INFO - Running post-action listener: _package_coverage_data 16:32:57 INFO - Running post-action listener: _resource_record_post_action 16:32:57 INFO - [mozharness: 2017-07-27 23:32:57.365377Z] Finished run-tests step (success) 16:32:57 INFO - Running post-run listener: _resource_record_post_run 16:32:57 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 28672; Write bytes: 433418240; Read time: 332; Write time: 385360 16:32:57 INFO - TinderboxPrint: CPU usage
13.1% 16:32:57 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 332 16:32:57 INFO - TinderboxPrint: I/O write bytes / time
433,418,240 / 385,360 16:32:57 INFO - TinderboxPrint: CPU idle
8,281.2 (86.8%) 16:32:57 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 16:32:57 INFO - TinderboxPrint: Swap in / out
0 / 0 16:32:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110796800; Read time: 200; Write time: 107772 16:32:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:32:57 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 20480; Write bytes: 322621440; Read time: 116; Write time: 277588 16:32:57 INFO - Running post-run listener: _upload_blobber_files 16:32:57 INFO - Blob upload gear active. 16:32:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:57 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 16:32:57 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:32:58 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:32:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:59 INFO - (blobuploader) - INFO - Done attempting. 16:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:59 INFO - (blobuploader) - INFO - Done attempting. 16:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:01 INFO - (blobuploader) - INFO - Done attempting. 16:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:04 INFO - (blobuploader) - INFO - Done attempting. 16:33:04 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:04 INFO - Return code: 0 16:33:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71001a704841560cc0759ed86b36e945027ed5ed45441d66cce22f8ea587dbdbf14a88a401fa8062172d1448cc0a0f6d41cf2346eb455273d714178b61c9a37b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bdece18f5fa26a7ea18af7c450fc65eda6a0d9585508b2b7d41f58d14f803a52beeb9b852e18dce05f63c601e803c69706ff94e236f450b13c3af9eaaec8248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9fa966b7c72ee63e7a57744d3e2424b2a1918bfc43af51453e14cf6bfdf485ffc3501738368aefc976f01dd18a3e804eaff8995c1cadeacd804bd51fd141ad1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d12dceaf611526ee31d20dd60e182ba556fc22d661c42fad5cd11873fed417362e31c13dc23f6cf3f9e2e913cc3a03bbd49d6113adba38323a4a2fb91993fd2"} 16:33:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:04 INFO - Contents: 16:33:04 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71001a704841560cc0759ed86b36e945027ed5ed45441d66cce22f8ea587dbdbf14a88a401fa8062172d1448cc0a0f6d41cf2346eb455273d714178b61c9a37b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bdece18f5fa26a7ea18af7c450fc65eda6a0d9585508b2b7d41f58d14f803a52beeb9b852e18dce05f63c601e803c69706ff94e236f450b13c3af9eaaec8248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9fa966b7c72ee63e7a57744d3e2424b2a1918bfc43af51453e14cf6bfdf485ffc3501738368aefc976f01dd18a3e804eaff8995c1cadeacd804bd51fd141ad1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d12dceaf611526ee31d20dd60e182ba556fc22d661c42fad5cd11873fed417362e31c13dc23f6cf3f9e2e913cc3a03bbd49d6113adba38323a4a2fb91993fd2"} 16:33:04 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:04 INFO - Copying logs to upload dir... 16:33:04 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.100992 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-27 16:33:05.008336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 16:33:05.015965) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612 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/sha512/71001a704841560cc0759ed86b36e945027ed5ed45441d66cce22f8ea587dbdbf14a88a401fa8062172d1448cc0a0f6d41cf2346eb455273d714178b61c9a37b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bdece18f5fa26a7ea18af7c450fc65eda6a0d9585508b2b7d41f58d14f803a52beeb9b852e18dce05f63c601e803c69706ff94e236f450b13c3af9eaaec8248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9fa966b7c72ee63e7a57744d3e2424b2a1918bfc43af51453e14cf6bfdf485ffc3501738368aefc976f01dd18a3e804eaff8995c1cadeacd804bd51fd141ad1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d12dceaf611526ee31d20dd60e182ba556fc22d661c42fad5cd11873fed417362e31c13dc23f6cf3f9e2e913cc3a03bbd49d6113adba38323a4a2fb91993fd2"} build_url:https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71001a704841560cc0759ed86b36e945027ed5ed45441d66cce22f8ea587dbdbf14a88a401fa8062172d1448cc0a0f6d41cf2346eb455273d714178b61c9a37b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bdece18f5fa26a7ea18af7c450fc65eda6a0d9585508b2b7d41f58d14f803a52beeb9b852e18dce05f63c601e803c69706ff94e236f450b13c3af9eaaec8248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9fa966b7c72ee63e7a57744d3e2424b2a1918bfc43af51453e14cf6bfdf485ffc3501738368aefc976f01dd18a3e804eaff8995c1cadeacd804bd51fd141ad1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d12dceaf611526ee31d20dd60e182ba556fc22d661c42fad5cd11873fed417362e31c13dc23f6cf3f9e2e913cc3a03bbd49d6113adba38323a4a2fb91993fd2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 16:33:05.042968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:33:05.043317) ========= 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=14ef55db36f7623abb31b9cf000001d5-1501197091.501825-1783892612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:33:05.092683) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 16:33:05.092997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 16:33:05.093302) ========= ========= Total master_lag: 0.22 =========