builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1505772881.76 results: success (0) revision: 678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.763779) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.764172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.764462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.781884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.782144) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 15:14:41-- 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% 46.1M=0s 2017-09-18 15:14:41 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126734 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.939246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:41.943560) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021964 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.015322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.015647) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 15:14:41,998 truncating revision to first 12 chars 2017-09-18 15:14:41,998 Setting DEBUG logging. 2017-09-18 15:14:41,999 attempt 1/10 2017-09-18 15:14:41,999 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/678bea28fe03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 15:14:42,345 unpacking tar archive at: mozilla-beta-678bea28fe03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641909 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.699338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.699628) ========= script_repo_revision: 678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.699989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.700246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:14:42.714716) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-18 15:14:42.714983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:42 INFO - MultiFileLogger online at 20170918 15:14:42 in /builds/slave/test 15:14:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 15:14:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:42 INFO - {'append_to_log': False, 15:14:42 INFO - 'base_work_dir': '/builds/slave/test', 15:14:42 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 15:14:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:42 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 15:14:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:42 INFO - 'code_coverage': False, 15:14:42 INFO - 'config_files': ('talos/linux_config.py',), 15:14:42 INFO - 'default_actions': ('clobber', 15:14:42 INFO - 'read-buildbot-config', 15:14:42 INFO - 'download-and-extract', 15:14:42 INFO - 'populate-webroot', 15:14:42 INFO - 'create-virtualenv', 15:14:42 INFO - 'install', 15:14:42 INFO - 'setup-mitmproxy', 15:14:42 INFO - 'run-tests'), 15:14:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:42 INFO - 'disable_ccov_upload': False, 15:14:42 INFO - 'download_minidump_stackwalk': True, 15:14:42 INFO - 'download_symbols': 'ondemand', 15:14:42 INFO - 'enable_stylo': False, 15:14:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:42 INFO - 'gecko_profile': False, 15:14:42 INFO - 'gecko_profile_interval': 0, 15:14:42 INFO - 'installer_path': 'installer.exe', 15:14:42 INFO - 'log_level': 'info', 15:14:42 INFO - 'log_name': 'talos', 15:14:42 INFO - 'log_to_console': True, 15:14:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:42 INFO - 'opt_config_files': (), 15:14:42 INFO - 'pip_index': False, 15:14:42 INFO - 'suite': 'dromaeojs-e10s', 15:14:42 INFO - 'system_bits': '32', 15:14:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:42 INFO - 'title': 'talos-linux64-ix-023', 15:14:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:42 INFO - 'use_talos_json': True, 15:14:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:42 INFO - 'work_dir': 'build'} 15:14:42 INFO - [mozharness: 2017-09-18 22:14:42.782967Z] Running clobber step. 15:14:42 INFO - Running pre-action listener: _resource_record_pre_action 15:14:42 INFO - Running main action method: clobber 15:14:42 INFO - rmtree: /builds/slave/test/build 15:14:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:43 INFO - Running post-action listener: _resource_record_post_action 15:14:43 INFO - [mozharness: 2017-09-18 22:14:43.788784Z] Finished clobber step (success) 15:14:43 INFO - [mozharness: 2017-09-18 22:14:43.788886Z] Running read-buildbot-config step. 15:14:43 INFO - Running pre-action listener: _resource_record_pre_action 15:14:43 INFO - Running main action method: read_buildbot_config 15:14:43 INFO - Using buildbot properties: 15:14:43 INFO - { 15:14:43 INFO - "project": "", 15:14:43 INFO - "product": "firefox", 15:14:43 INFO - "who": "ryanvm@gmail.com", 15:14:43 INFO - "installer_path": "public/build/target.tar.bz2", 15:14:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:14:43 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 15:14:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 15:14:43 INFO - "stage_platform": "linux64", 15:14:43 INFO - "basedir": "/builds/slave/test", 15:14:43 INFO - "buildnumber": 94, 15:14:43 INFO - "platform": "ubuntu64_hw", 15:14:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:14:43 INFO - "slavebuilddir": "test", 15:14:43 INFO - "taskId": "JYmP4x_aTcyf9tvgSFOIag", 15:14:43 INFO - "branch": "mozilla-beta", 15:14:43 INFO - "script_repo_revision": "production", 15:14:43 INFO - "revision": "678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8", 15:14:43 INFO - "slavename": "talos-linux64-ix-023", 15:14:43 INFO - "repo_path": "releases/mozilla-beta" 15:14:43 INFO - } 15:14:43 INFO - Finding installer, test and symbols from parent task. 15:14:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JYmP4x_aTcyf9tvgSFOIag'}, attempt #1 15:14:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JYmP4x_aTcyf9tvgSFOIag'}, attempt #1 15:14:44 INFO - Task dependencies: U1IqJAEYRfKg0fMDakqifw 15:14:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw'}, attempt #1 15:14:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2 15:14:45 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.test_packages.json 15:14:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.crashreporter-symbols.zip 15:14:45 INFO - Running post-action listener: _resource_record_post_action 15:14:45 INFO - [mozharness: 2017-09-18 22:14:45.216429Z] Finished read-buildbot-config step (success) 15:14:45 INFO - [mozharness: 2017-09-18 22:14:45.216707Z] Running download-and-extract step. 15:14:45 INFO - Running pre-action listener: _resource_record_pre_action 15:14:45 INFO - Running main action method: download_and_extract 15:14:45 INFO - mkdir: /builds/slave/test/build/tests 15:14: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')]} 15:14:45 INFO - trying https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.test_packages.json 15:14:45 INFO - Downloading https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:14:45 INFO - Downloaded 989 bytes. 15:14:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:14:45 INFO - Using the following test package requirements: 15:14:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:14:45 INFO - u'common': [u'target.common.tests.zip'], 15:14:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:14:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:14:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:14:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:14:45 INFO - u'mozbase': [u'target.common.tests.zip'], 15:14:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:14:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:14:45 INFO - u'web-platform': [u'target.common.tests.zip', 15:14:45 INFO - u'target.web-platform.tests.tar.gz'], 15:14:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:14:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:14:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.common.tests.zip 15:14:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:14:45 INFO - Fetch https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.common.tests.zip into memory 15:14:48 INFO - Content-Length response header: 72857667 15:14:48 INFO - Bytes received: 72857667 15:14:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.talos.tests.zip 15:14:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:14:59 INFO - Fetch https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.talos.tests.zip into memory 15:15:01 INFO - Content-Length response header: 14496472 15:15:01 INFO - Bytes received: 14496472 15:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:01 INFO - trying https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2 15:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:15:03 INFO - Downloaded 54257060 bytes. 15:15:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2 15:15:03 INFO - mkdir: /builds/slave/test/properties 15:15:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:03 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:03 INFO - Contents: 15:15:03 INFO - build_url:https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2 15:15:03 INFO - Running post-action listener: _resource_record_post_action 15:15:03 INFO - Running post-action listener: set_extra_try_arguments 15:15:03 INFO - [mozharness: 2017-09-18 22:15:03.962342Z] Finished download-and-extract step (success) 15:15:03 INFO - [mozharness: 2017-09-18 22:15:03.962441Z] Running populate-webroot step. 15:15:03 INFO - Running pre-action listener: _resource_record_pre_action 15:15:03 INFO - Running main action method: populate_webroot 15:15:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:15:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:15:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:15:03 INFO - 'tests': ['damp', 'tps']}, 15:15:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:15:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:15:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:15:03 INFO - 'other-e10s': {'tests': ['a11yr', 15:15:03 INFO - 'ts_paint', 15:15:03 INFO - 'tpaint', 15:15:03 INFO - 'sessionrestore', 15:15:03 INFO - 'sessionrestore_many_windows', 15:15:03 INFO - 'sessionrestore_no_auto_restore', 15:15:03 INFO - 'tabpaint']}, 15:15:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:15:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:15:03 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:15:03 INFO - 'talos_options': ['--mitmproxy', 15:15:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:15:03 INFO - '--firstNonBlankPaint'], 15:15:03 INFO - 'tests': ['quantum_pageload_google', 15:15:03 INFO - 'quantum_pageload_youtube', 15:15:03 INFO - 'quantum_pageload_amazon', 15:15:03 INFO - 'quantum_pageload_facebook']}, 15:15:03 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:15:03 INFO - 'talos_options': ['--stylo', 15:15:03 INFO - '--mitmproxy', 15:15:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:15:03 INFO - '--firstNonBlankPaint'], 15:15:03 INFO - 'tests': ['quantum_pageload_google', 15:15:03 INFO - 'quantum_pageload_youtube', 15:15:03 INFO - 'quantum_pageload_amazon', 15:15:03 INFO - 'quantum_pageload_facebook']}, 15:15:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:15:03 INFO - 'tsvgr_opacity', 15:15:03 INFO - 'tart', 15:15:03 INFO - 'tscrollx', 15:15:03 INFO - 'cart', 15:15:03 INFO - 'tsvg_static']}, 15:15:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:15:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:15:03 INFO - 'talos_options': ['--stylo', 15:15:03 INFO - '--stylo-threads=1', 15:15:03 INFO - '--mitmproxy', 15:15:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:15:03 INFO - '--firstNonBlankPaint'], 15:15:03 INFO - 'tests': ['tp6_google', 15:15:03 INFO - 'tp6_youtube', 15:15:03 INFO - 'tp6_amazon', 15:15:03 INFO - 'tp6_facebook']}, 15:15:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:15:03 INFO - 'talos_options': ['--xperf_path', 15:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:03 INFO - 'tests': ['tp5n']}}} 15:15:03 INFO - Running post-action listener: _resource_record_post_action 15:15:03 INFO - [mozharness: 2017-09-18 22:15:03.971105Z] Finished populate-webroot step (success) 15:15:03 INFO - [mozharness: 2017-09-18 22:15:03.971197Z] Running create-virtualenv step. 15:15:03 INFO - Running pre-action listener: _resource_record_pre_action 15:15:03 INFO - Running main action method: create_virtualenv 15:15:03 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:03 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 15:15:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:15:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:04 INFO - Using real prefix '/usr' 15:15:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:04 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:06 INFO - Installing pip.................done. 15:15:06 INFO - Return code: 0 15:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:15:06 INFO - Reading from file tmpfile_stdout 15:15:06 INFO - Output received: 15:15:06 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) 15:15:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:15:06 INFO - Using env: {'DISPLAY': ':0', 15:15:06 INFO - 'HOME': '/home/cltbld', 15:15:06 INFO - 'LANG': 'en_US.UTF-8', 15:15:06 INFO - 'LANGUAGE': 'en_US:en', 15:15:06 INFO - 'LOGNAME': 'cltbld', 15:15:06 INFO - 'MAIL': '/var/mail/cltbld', 15:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:06 INFO - 'MOZ_NO_REMOTE': '1', 15:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:06 INFO - 'NO_EM_RESTART': '1', 15:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:06 INFO - 'PWD': '/builds/slave/test', 15:15:06 INFO - 'SHELL': '/bin/bash', 15:15:06 INFO - 'SHLVL': '1', 15:15:06 INFO - 'TERM': 'linux', 15:15:06 INFO - 'TMOUT': '86400', 15:15:06 INFO - 'USER': 'cltbld', 15:15:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:06 INFO - '_': '/tools/buildbot/bin/python'} 15:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:06 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 15:15:06 INFO - Cleaning up... 15:15:07 INFO - Return code: 0 15:15:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:07 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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:07 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 15:15:07 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 15:15:07 INFO - Using env: {'DISPLAY': ':0', 15:15:07 INFO - 'HOME': '/home/cltbld', 15:15:07 INFO - 'LANG': 'en_US.UTF-8', 15:15:07 INFO - 'LANGUAGE': 'en_US:en', 15:15:07 INFO - 'LOGNAME': 'cltbld', 15:15:07 INFO - 'MAIL': '/var/mail/cltbld', 15:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:07 INFO - 'MOZ_NO_REMOTE': '1', 15:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:07 INFO - 'NO_EM_RESTART': '1', 15:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:07 INFO - 'PWD': '/builds/slave/test', 15:15:07 INFO - 'SHELL': '/bin/bash', 15:15:07 INFO - 'SHLVL': '1', 15:15:07 INFO - 'TERM': 'linux', 15:15:07 INFO - 'TMOUT': '86400', 15:15:07 INFO - 'USER': 'cltbld', 15:15:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:07 INFO - '_': '/tools/buildbot/bin/python'} 15:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:07 INFO - Downloading/unpacking psutil>=3.1.1 15:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:09 INFO - Installing collected packages: psutil 15:15:09 INFO - Running setup.py install for psutil 15:15:09 INFO - building 'psutil._psutil_linux' extension 15:15:09 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 15:15:09 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 15:15:09 INFO - building 'psutil._psutil_posix' extension 15:15:09 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 15:15:09 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 15:15:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:10 INFO - Successfully installed psutil 15:15:10 INFO - Cleaning up... 15:15:10 INFO - Return code: 0 15:15:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:10 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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:10 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 15:15:10 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 15:15:10 INFO - Using env: {'DISPLAY': ':0', 15:15:10 INFO - 'HOME': '/home/cltbld', 15:15:10 INFO - 'LANG': 'en_US.UTF-8', 15:15:10 INFO - 'LANGUAGE': 'en_US:en', 15:15:10 INFO - 'LOGNAME': 'cltbld', 15:15:10 INFO - 'MAIL': '/var/mail/cltbld', 15:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:10 INFO - 'MOZ_NO_REMOTE': '1', 15:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:10 INFO - 'NO_EM_RESTART': '1', 15:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:10 INFO - 'PWD': '/builds/slave/test', 15:15:10 INFO - 'SHELL': '/bin/bash', 15:15:10 INFO - 'SHLVL': '1', 15:15:10 INFO - 'TERM': 'linux', 15:15:10 INFO - 'TMOUT': '86400', 15:15:10 INFO - 'USER': 'cltbld', 15:15:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:10 INFO - '_': '/tools/buildbot/bin/python'} 15:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:15:10 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 15:15:10 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 15:15:10 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 15:15:10 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 15:15:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:15:11 INFO - Installing collected packages: mozsystemmonitor 15:15:11 INFO - Running setup.py install for mozsystemmonitor 15:15:11 INFO - Successfully installed mozsystemmonitor 15:15:11 INFO - Cleaning up... 15:15:11 INFO - Return code: 0 15:15:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:11 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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:11 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 15:15:11 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 15:15:11 INFO - Using env: {'DISPLAY': ':0', 15:15:11 INFO - 'HOME': '/home/cltbld', 15:15:11 INFO - 'LANG': 'en_US.UTF-8', 15:15:11 INFO - 'LANGUAGE': 'en_US:en', 15:15:11 INFO - 'LOGNAME': 'cltbld', 15:15:11 INFO - 'MAIL': '/var/mail/cltbld', 15:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:11 INFO - 'MOZ_NO_REMOTE': '1', 15:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:11 INFO - 'NO_EM_RESTART': '1', 15:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:11 INFO - 'PWD': '/builds/slave/test', 15:15:11 INFO - 'SHELL': '/bin/bash', 15:15:11 INFO - 'SHLVL': '1', 15:15:11 INFO - 'TERM': 'linux', 15:15:11 INFO - 'TMOUT': '86400', 15:15:11 INFO - 'USER': 'cltbld', 15:15:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:11 INFO - '_': '/tools/buildbot/bin/python'} 15:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:12 INFO - Downloading/unpacking jsonschema==2.5.1 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:13 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:13 INFO - warning: no files found matching '*.txt' 15:15:13 INFO - no previously-included directories found matching 'build' 15:15:13 INFO - no previously-included directories found matching 'dist' 15:15:13 INFO - no previously-included directories found matching '.git*' 15:15:13 INFO - Installing collected packages: jsonschema, functools32 15:15:13 INFO - Running setup.py install for functools32 15:15:13 INFO - warning: no files found matching '*.txt' 15:15:13 INFO - no previously-included directories found matching 'build' 15:15:13 INFO - no previously-included directories found matching 'dist' 15:15:13 INFO - no previously-included directories found matching '.git*' 15:15:13 INFO - Successfully installed jsonschema functools32 15:15:13 INFO - Cleaning up... 15:15:13 INFO - Return code: 0 15:15:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:15:13 INFO - Using env: {'DISPLAY': ':0', 15:15:13 INFO - 'HOME': '/home/cltbld', 15:15:13 INFO - 'LANG': 'en_US.UTF-8', 15:15:13 INFO - 'LANGUAGE': 'en_US:en', 15:15:13 INFO - 'LOGNAME': 'cltbld', 15:15:13 INFO - 'MAIL': '/var/mail/cltbld', 15:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:13 INFO - 'MOZ_NO_REMOTE': '1', 15:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:13 INFO - 'NO_EM_RESTART': '1', 15:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:13 INFO - 'PWD': '/builds/slave/test', 15:15:13 INFO - 'SHELL': '/bin/bash', 15:15:13 INFO - 'SHLVL': '1', 15:15:13 INFO - 'TERM': 'linux', 15:15:13 INFO - 'TMOUT': '86400', 15:15:13 INFO - 'USER': 'cltbld', 15:15:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:13 INFO - '_': '/tools/buildbot/bin/python'} 15:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:15:13 INFO - Cleaning up... 15:15:13 INFO - Return code: 0 15:15:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:15:13 INFO - Using env: {'DISPLAY': ':0', 15:15:13 INFO - 'HOME': '/home/cltbld', 15:15:13 INFO - 'LANG': 'en_US.UTF-8', 15:15:13 INFO - 'LANGUAGE': 'en_US:en', 15:15:13 INFO - 'LOGNAME': 'cltbld', 15:15:13 INFO - 'MAIL': '/var/mail/cltbld', 15:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:13 INFO - 'MOZ_NO_REMOTE': '1', 15:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:13 INFO - 'NO_EM_RESTART': '1', 15:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:13 INFO - 'PWD': '/builds/slave/test', 15:15:13 INFO - 'SHELL': '/bin/bash', 15:15:13 INFO - 'SHLVL': '1', 15:15:13 INFO - 'TERM': 'linux', 15:15:13 INFO - 'TMOUT': '86400', 15:15:13 INFO - 'USER': 'cltbld', 15:15:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:13 INFO - '_': '/tools/buildbot/bin/python'} 15:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:14 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 15:15:14 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 15:15:14 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 15:15:14 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 15:15:15 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:15 INFO - Downloading docopt-0.6.1.tar.gz 15:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:15 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:15 INFO - Running setup.py install for blobuploader 15:15:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:15 INFO - Running setup.py install for requests 15:15:16 INFO - Running setup.py install for docopt 15:15:16 INFO - Successfully installed blobuploader requests docopt 15:15:16 INFO - Cleaning up... 15:15:16 INFO - Return code: 0 15:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:16 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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:16 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 15:15:16 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 15:15:16 INFO - Using env: {'DISPLAY': ':0', 15:15:16 INFO - 'HOME': '/home/cltbld', 15:15:16 INFO - 'LANG': 'en_US.UTF-8', 15:15:16 INFO - 'LANGUAGE': 'en_US:en', 15:15:16 INFO - 'LOGNAME': 'cltbld', 15:15:16 INFO - 'MAIL': '/var/mail/cltbld', 15:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:16 INFO - 'MOZ_NO_REMOTE': '1', 15:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:16 INFO - 'NO_EM_RESTART': '1', 15:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:16 INFO - 'PWD': '/builds/slave/test', 15:15:16 INFO - 'SHELL': '/bin/bash', 15:15:16 INFO - 'SHLVL': '1', 15:15:16 INFO - 'TERM': 'linux', 15:15:16 INFO - 'TMOUT': '86400', 15:15:16 INFO - 'USER': 'cltbld', 15:15:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:16 INFO - '_': '/tools/buildbot/bin/python'} 15:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:16 INFO - Running setup.py (path:/tmp/pip-zZJ3Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:16 INFO - Running setup.py (path:/tmp/pip-7gsQcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:16 INFO - Running setup.py (path:/tmp/pip-bvUn31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:16 INFO - Running setup.py (path:/tmp/pip-7igbDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:16 INFO - Running setup.py (path:/tmp/pip-7Ei6o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:16 INFO - Running setup.py (path:/tmp/pip-02rLH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:16 INFO - Running setup.py (path:/tmp/pip-TtjXlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:17 INFO - Running setup.py (path:/tmp/pip-WVzBAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:17 INFO - Running setup.py (path:/tmp/pip-THaGP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:17 INFO - Running setup.py (path:/tmp/pip-sqvxVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:17 INFO - Running setup.py (path:/tmp/pip-KJbKKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:17 INFO - Running setup.py (path:/tmp/pip-ythoC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:17 INFO - Running setup.py (path:/tmp/pip-99UaFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:17 INFO - Running setup.py (path:/tmp/pip-FbDxbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:17 INFO - Running setup.py (path:/tmp/pip-RAvTH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:17 INFO - Running setup.py (path:/tmp/pip-szyIZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:17 INFO - Running setup.py (path:/tmp/pip-a47AKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:17 INFO - Running setup.py install for manifestparser 15:15:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:17 INFO - Running setup.py install for mozcrash 15:15:17 INFO - Running setup.py install for mozdebug 15:15:18 INFO - Running setup.py install for mozdevice 15:15:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Running setup.py install for mozfile 15:15:18 INFO - Running setup.py install for mozhttpd 15:15:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Running setup.py install for mozinfo 15:15:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Running setup.py install for mozInstall 15:15:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Running setup.py install for mozleak 15:15:18 INFO - Running setup.py install for mozlog 15:15:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Running setup.py install for moznetwork 15:15:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:18 INFO - Running setup.py install for mozprocess 15:15:19 INFO - Running setup.py install for mozprofile 15:15:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:19 INFO - Running setup.py install for mozrunner 15:15:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:19 INFO - Running setup.py install for mozscreenshot 15:15:19 INFO - Running setup.py install for moztest 15:15:19 INFO - Running setup.py install for mozversion 15:15:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:19 INFO - Cleaning up... 15:15:19 INFO - Return code: 0 15:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15: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')]} 15:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:19 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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:19 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 15:15:19 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 15:15:19 INFO - Using env: {'DISPLAY': ':0', 15:15:19 INFO - 'HOME': '/home/cltbld', 15:15:19 INFO - 'LANG': 'en_US.UTF-8', 15:15:19 INFO - 'LANGUAGE': 'en_US:en', 15:15:19 INFO - 'LOGNAME': 'cltbld', 15:15:19 INFO - 'MAIL': '/var/mail/cltbld', 15:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:19 INFO - 'MOZ_NO_REMOTE': '1', 15:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:19 INFO - 'NO_EM_RESTART': '1', 15:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:19 INFO - 'PWD': '/builds/slave/test', 15:15:19 INFO - 'SHELL': '/bin/bash', 15:15:19 INFO - 'SHLVL': '1', 15:15:19 INFO - 'TERM': 'linux', 15:15:19 INFO - 'TMOUT': '86400', 15:15:19 INFO - 'USER': 'cltbld', 15:15:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:19 INFO - '_': '/tools/buildbot/bin/python'} 15:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:19 INFO - Running setup.py (path:/tmp/pip-7rKEl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:19 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)) 15:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:19 INFO - Running setup.py (path:/tmp/pip-0yC3SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:19 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)) 15:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:19 INFO - Running setup.py (path:/tmp/pip-v_UtAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:20 INFO - Running setup.py (path:/tmp/pip-PAnyQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:20 INFO - Running setup.py (path:/tmp/pip-RyHAjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:20 INFO - Running setup.py (path:/tmp/pip-zHjt6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:20 INFO - Running setup.py (path:/tmp/pip-dcjyjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:20 INFO - Running setup.py (path:/tmp/pip-gNI086-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:20 INFO - Running setup.py (path:/tmp/pip-oYSslq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:20 INFO - Running setup.py (path:/tmp/pip-rQWYx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:20 INFO - Running setup.py (path:/tmp/pip-QpXafW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:20 INFO - Running setup.py (path:/tmp/pip-CJzwOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:20 INFO - Running setup.py (path:/tmp/pip-kk6Sgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:20 INFO - Running setup.py (path:/tmp/pip-IECxWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:20 INFO - Running setup.py (path:/tmp/pip-kCPLEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:20 INFO - Running setup.py (path:/tmp/pip-KlQtp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:20 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)) 15:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:20 INFO - Running setup.py (path:/tmp/pip-jRhk6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:21 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)) 15:15:21 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)) 15:15:21 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)) 15:15:21 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)) 15:15:21 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)) 15:15:21 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)) 15:15:21 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)) 15:15:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:21 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 15:15:21 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 15:15:21 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 15:15:21 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 15:15:22 INFO - Downloading blessings-1.6.tar.gz 15:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:22 INFO - Installing collected packages: blessings 15:15:22 INFO - Running setup.py install for blessings 15:15:22 INFO - Successfully installed blessings 15:15:22 INFO - Cleaning up... 15:15:22 INFO - Return code: 0 15:15:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:22 INFO - Reading from file tmpfile_stdout 15:15:22 INFO - Current package versions: 15:15:22 INFO - argparse == 1.2.1 15:15:22 INFO - blessings == 1.6 15:15:22 INFO - blobuploader == 1.2.4 15:15:22 INFO - docopt == 0.6.1 15:15:22 INFO - functools32 == 3.2.3-2 15:15:22 INFO - jsonschema == 2.5.1 15:15:22 INFO - manifestparser == 1.1 15:15:22 INFO - mozInstall == 1.13 15:15:22 INFO - mozcrash == 1.0 15:15:22 INFO - mozdebug == 0.1 15:15:22 INFO - mozdevice == 0.51 15:15:22 INFO - mozfile == 1.2 15:15:22 INFO - mozhttpd == 0.7 15:15:22 INFO - mozinfo == 0.10 15:15:22 INFO - mozleak == 0.1 15:15:22 INFO - mozlog == 3.5 15:15:22 INFO - moznetwork == 0.27 15:15:22 INFO - mozprocess == 0.25 15:15:22 INFO - mozprofile == 0.28 15:15:22 INFO - mozrunner == 6.13 15:15:22 INFO - mozscreenshot == 0.1 15:15:22 INFO - mozsystemmonitor == 0.3 15:15:22 INFO - moztest == 0.8 15:15:22 INFO - mozversion == 1.4 15:15:22 INFO - psutil == 3.1.1 15:15:22 INFO - requests == 1.2.3 15:15:22 INFO - wsgiref == 0.1.2 15:15:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:22 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')]} 15:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:22 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')]} 15:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:22 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 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:22 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 15:15:22 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 15:15:22 INFO - Using env: {'DISPLAY': ':0', 15:15:22 INFO - 'HOME': '/home/cltbld', 15:15:22 INFO - 'LANG': 'en_US.UTF-8', 15:15:22 INFO - 'LANGUAGE': 'en_US:en', 15:15:22 INFO - 'LOGNAME': 'cltbld', 15:15:22 INFO - 'MAIL': '/var/mail/cltbld', 15:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:22 INFO - 'MOZ_NO_REMOTE': '1', 15:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:22 INFO - 'NO_EM_RESTART': '1', 15:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:22 INFO - 'PWD': '/builds/slave/test', 15:15:22 INFO - 'SHELL': '/bin/bash', 15:15:22 INFO - 'SHLVL': '1', 15:15:22 INFO - 'TERM': 'linux', 15:15:22 INFO - 'TMOUT': '86400', 15:15:22 INFO - 'USER': 'cltbld', 15:15:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:22 INFO - '_': '/tools/buildbot/bin/python'} 15:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 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)) 15:15:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:15:22 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 15:15:22 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 15:15:22 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 15:15:22 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 15:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:15:24 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)) 15:15:24 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)) 15:15:24 INFO - Installing collected packages: simplejson 15:15:24 INFO - Running setup.py install for simplejson 15:15:24 INFO - building 'simplejson._speedups' extension 15:15:24 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 15:15:24 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 15:15:25 INFO - Successfully installed simplejson 15:15:25 INFO - Cleaning up... 15:15:25 INFO - Return code: 0 15:15:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2130eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', '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 15:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:15:25 INFO - Using env: {'DISPLAY': ':0', 15:15:25 INFO - 'HOME': '/home/cltbld', 15:15:25 INFO - 'LANG': 'en_US.UTF-8', 15:15:25 INFO - 'LANGUAGE': 'en_US:en', 15:15:25 INFO - 'LOGNAME': 'cltbld', 15:15:25 INFO - 'MAIL': '/var/mail/cltbld', 15:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:25 INFO - 'MOZ_NO_REMOTE': '1', 15:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:25 INFO - 'NO_EM_RESTART': '1', 15:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:25 INFO - 'PWD': '/builds/slave/test', 15:15:25 INFO - 'SHELL': '/bin/bash', 15:15:25 INFO - 'SHLVL': '1', 15:15:25 INFO - 'TERM': 'linux', 15:15:25 INFO - 'TMOUT': '86400', 15:15:25 INFO - 'USER': 'cltbld', 15:15:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:25 INFO - '_': '/tools/buildbot/bin/python'} 15:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:15:25 INFO - Cleaning up... 15:15:25 INFO - Return code: 0 15:15:25 INFO - Running post-action listener: _resource_record_post_action 15:15:25 INFO - Running post-action listener: _start_resource_monitoring 15:15:25 INFO - Starting resource monitoring. 15:15:25 INFO - [mozharness: 2017-09-18 22:15:25.314655Z] Finished create-virtualenv step (success) 15:15:25 INFO - [mozharness: 2017-09-18 22:15:25.315168Z] Running install step. 15:15:25 INFO - Running pre-action listener: _resource_record_pre_action 15:15:25 INFO - Running main action method: install 15:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:25 INFO - Reading from file tmpfile_stdout 15:15:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:25 INFO - Reading from file tmpfile_stdout 15:15:25 INFO - Output received: 15:15:25 INFO - Usage: mozinstall [options] installer 15:15:25 INFO - Options: 15:15:25 INFO - -h, --help show this help message and exit 15:15:25 INFO - -d DEST, --destination=DEST 15:15:25 INFO - Directory to install application into. [default: 15:15:25 INFO - "/builds/slave/test"] 15:15:25 INFO - --app=APP Application being installed. [default: firefox] 15:15:25 INFO - mkdir: /builds/slave/test/build/application 15:15:25 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'] 15:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:15:40 INFO - Reading from file tmpfile_stdout 15:15:40 INFO - Output received: 15:15:40 INFO - /builds/slave/test/build/application/firefox/firefox 15:15:40 INFO - Running post-action listener: _resource_record_post_action 15:15:40 INFO - [mozharness: 2017-09-18 22:15:40.434513Z] Finished install step (success) 15:15:40 INFO - [mozharness: 2017-09-18 22:15:40.434663Z] Running setup-mitmproxy step. 15:15:40 INFO - Running pre-action listener: _resource_record_pre_action 15:15:40 INFO - Running main action method: setup_mitmproxy 15:15:40 INFO - Skipping: mitmproxy is not required 15:15:40 INFO - Running post-action listener: _resource_record_post_action 15:15:40 INFO - [mozharness: 2017-09-18 22:15:40.435203Z] Finished setup-mitmproxy step (success) 15:15:40 INFO - [mozharness: 2017-09-18 22:15:40.435307Z] Running run-tests step. 15:15:40 INFO - Running pre-action listener: _resource_record_pre_action 15:15:40 INFO - Running pre-action listener: _set_gcov_prefix 15:15:40 INFO - Running main action method: run_tests 15:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:40 INFO - Python 2.7.3 15:15:40 INFO - Return code: 0 15:15:40 INFO - grabbing minidump binary from tooltool 15:15:40 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')]} 15:15:40 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 0x212e050>, '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 0x212ef50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212f3e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:40 INFO - Return code: 0 15:15:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:15:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:40 INFO - ENV: RUST_BACKTRACE is now 1 15:15:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:15:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:15:40 INFO - Using env: {'DISPLAY': ':0', 15:15:40 INFO - 'HOME': '/home/cltbld', 15:15:40 INFO - 'LANG': 'en_US.UTF-8', 15:15:40 INFO - 'LANGUAGE': 'en_US:en', 15:15:40 INFO - 'LOGNAME': 'cltbld', 15:15:40 INFO - 'MAIL': '/var/mail/cltbld', 15:15:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:40 INFO - 'MOZ_NO_REMOTE': '1', 15:15:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:40 INFO - 'NO_EM_RESTART': '1', 15:15:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:40 INFO - 'PWD': '/builds/slave/test', 15:15:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:40 INFO - 'RUST_BACKTRACE': '1', 15:15:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:15:40 INFO - 'SHELL': '/bin/bash', 15:15:40 INFO - 'SHLVL': '1', 15:15:40 INFO - 'TERM': 'linux', 15:15:40 INFO - 'TMOUT': '86400', 15:15:40 INFO - 'USER': 'cltbld', 15:15:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009', 15:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:40 INFO - '_': '/tools/buildbot/bin/python'} 15:15:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:15:40 INFO - mozversion application_buildid: 20170918210818 15:15:40 INFO - mozversion application_changeset: 678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8 15:15:40 INFO - mozversion application_display_name: Firefox 15:15:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:40 INFO - mozversion application_name: Firefox 15:15:40 INFO - mozversion application_remotingname: firefox 15:15:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:15:40 INFO - mozversion application_vendor: Mozilla 15:15:40 INFO - mozversion application_version: 56.0 15:15:40 INFO - mozversion platform_buildid: 20170918210818 15:15:40 INFO - mozversion platform_changeset: 678bea28fe03daa91c40f50a5a9d5fc3a9dc57f8 15:15:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:15:40 INFO - mozversion platform_version: 56.0 15:15:40 INFO - using testdate: 1505772940 15:15:40 INFO - actual date: 1505772940 15:15:40 INFO - starting webserver on 'localhost:45270' 15:15:40 INFO - SUITE-START | Running 2 tests 15:15:40 INFO - TEST-START | dromaeo_css 15:15:40 INFO - Initialising browser for dromaeo_css test... 15:15:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45270/getInfo.html -profile /tmp/tmpYOb2BU/profile 15:15:40 INFO - TEST-INFO | started process 8915 (/builds/slave/test/build/application/firefox/firefox http://localhost:45270/getInfo.html) 15:15:46 INFO - TEST-INFO | 8915: exit 0 15:15:46 INFO - Browser initialized. 15:15:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:46 INFO - TEST-INFO | started process 9078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYOb2BU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:57 INFO - PID 9078 | RSS: Main: 150913024 15:15:57 INFO - PID 9078 | 15:18:55 INFO - PID 9078 | Cycle 1(1): loaded http://localhost:45270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45270/tests/dromaeo/cssquery-ext.html) 15:18:56 INFO - PID 9078 | RSS: Main: 160567296 15:18:56 INFO - PID 9078 | 15:21:58 INFO - PID 9078 | Cycle 1(1): loaded http://localhost:45270/tests/dromaeo/cssquery-ext.html (next: http://localhost:45270/tests/dromaeo/cssquery-jquery.html) 15:21:58 INFO - PID 9078 | RSS: Main: 157364224 15:21:58 INFO - PID 9078 | 15:25:00 INFO - PID 9078 | Cycle 1(1): loaded http://localhost:45270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45270/tests/dromaeo/cssquery-mootools.html) 15:25:00 INFO - PID 9078 | RSS: Main: 158695424 15:25:00 INFO - PID 9078 | 15:28:02 INFO - PID 9078 | Cycle 1(1): loaded http://localhost:45270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45270/tests/dromaeo/cssquery-prototype.html) 15:28:03 INFO - PID 9078 | RSS: Main: 158683136 15:28:03 INFO - PID 9078 | 15:31:06 INFO - PID 9078 | Cycle 1(1): loaded http://localhost:45270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45270/tests/dromaeo/cssquery-yui.html) 15:31:06 INFO - PID 9078 | RSS: Main: 160849920 15:31:06 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | Cycle 1(1): loaded http://localhost:45270/tests/dromaeo/cssquery-yui.html (next: http://localhost:45270/tests/dromaeo/cssquery-dojo.html) 15:34:08 INFO - PID 9078 | RSS: Main: 163057664 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | __start_tp_report 15:34:08 INFO - PID 9078 | _x_x_mozilla_page_load 15:34:08 INFO - PID 9078 | _x_x_mozilla_page_load_details 15:34:08 INFO - PID 9078 | |i|pagename|runs| 15:34:08 INFO - PID 9078 | |0;dojo.html;3554.8222588870567;3573.7141028717706;3610.2598967211725;3615;3631.473436351729;6335.049742538621;6385.521085918557;6400.967995160024;6423.229212494495;6468.902966455507;6310.968445157768;6340.841478963017;6449.6130232186215;6450.0324951257335;6459.257185423666;5443.237946687467;5524.116141417374;5531.2532808071;5592.356878958911;5607.046802043642;5588.133839254922;5620.1288800236025;5626.2967129108865;5629.60592758507;5662.292213473316;5595.664260144405;5605.215269862222;5620.381758006616;5670.5747068969995;5688.516476099537;5547.417521160261;5597.048501754671;5621.072523033695;5631.2960879890015;5631.63394379364;5497.45025497451;5525.309336332958;5545.500904918536;5565.749541270652;5574.526165275915;6211;6241.251049874044;6253.968730156365;6292.5595208335435;6309.905351419732;6718.932810671929;6766.594004359754;6777.491688123361;6782.491313151533;6785.1518560179975;6854.862902741967;6928.4803639726715;6936.265933516621;6961.37347638715;7005.929940700578;6405.935940640627;6420.293767685551;6463.450606698436;6472.482201423922;6497.415232629086;6909.654517274116;6991.265917078634;6991.335823096798;7010.369066784014;7061.82345441368;6764.154480689914;6787.185537735503;6799.796006119825;6843.7604683835825;6853.417459515997;6888.621125838127;6922.480813938974;7008.754693585802;7009.754658586925;7013.929860701328;6874.896876546856;6884.896726549106;6891.827704307332;6965.477589180831;6969.337912898267;6677.265500794909;6798.354156355237;6838.863222735517;6869.107016087976;6945.89581156283;5140.3831540215415;5143.382794064736;5149.150390185578;5155.02054609623;5155.690658560498;4443.244648409778;4533.682642215079;4578.084383123389;4578.816847326137;4584.701994370355;6506.772262970868;6578.440832529289;6588.703508342041;6658.4673226141795;6662.300458451889;6958.199807022156;6971.65141742921;6978.685959131852;6987.965060174666;7007.92992070083;6492;6500.642464664489;6544.9672751635935;6556.147700798866;6570.77002304917;5618.157276408571;5648.322201335866;5657.179708942181;5733.827985160452;5745.1382292656435;7197.280271972761;7253.020842186343;7256.7460138894885;7262.419006479469;7286.380657644159;6871.072405225231;6890.31096890307;6901.62041087745;6973.372396484341;6982.6508674567085;7023.367896889305;7162.176349719849;7165.964170179116;7276.745313913988;7278.6724597392185;6739.696713647995;6843.486738494533;6858.8285292866085;6867.038614593861;6884.586924784529;6985.930140698528;6997.580145191305;7049.682764275723;7064.682089305891;7067.151941767021;6714.496412769159;6722;6726.630035348103;6811.863762724817;6811.931880681328;6571.901421478778;6635.6350400728425;6638.236602790741;6640.037194606658;6646.83382915431;6656.7670131545165;6685.8997115044285;6729.461643068641;6764.425023873026;6782.864342713019;6670.266270710315;6753.15585551806;6803.7618683345845;6805.0472933788315;6838.863222735617;6301.180846489927;6435.4529864962005;6488.091667166506;6526.902096468461;6619.139511863427 15:34:08 INFO - PID 9078 | |1;ext.html;900.2617853360243;907.3739120007194;941.9434833909964;948.7011591348729;955.8518429643408;44561.77719111404;45356;45488.54511454885;45529.317060244124;45555.54444455555;41723.58276417235;41770.373444398356;42204.788976055075;42294.57705422945;42359.57640423595;7153;7320.267973202664;7321.816954576151;7329.853402931938;7332.633368331589;7224.674889629953;7310.378617817492;7311.780646580584;7318.890216646754;7320.414366850639;7988.360931125525;8119.797005074891;8176.591170441484;8180.590970451483;8185.79535511611;8045.557494337839;8105;8117.269445749911;8120.512769233836;8121.147279535623;7860.842783144305;7872.803179920491;7907.565083920382;7947.483413578099;7948.244916732901;42751.144977100594;42839.85800709952;42852.35721464181;42876;42880.785596072135;3788.2234142000825;3796.240751849641;3799.734018618698;3823.3691440912216;3825.9808700956596;33429;33474.66101355943;33475.49786753201;33598;33604;5254.710990895499;5273.1035723927025;5276.445973172838;5277.1820367842665;5292.973535132338;220909;222210;227668;229045.99999999834;229616;53828;54456.45543544593;54613.45386546083;54687.45312546903;54777.45222547803;57107.71446142826;57583.13625295624;57712.71143644255;57776.42223577794;57919.71040144772;18204.180811863498;18323.35868244605;18326.266949322144;18327.266909323476;18329.633407331778;15145;15155.090694558361;15163.772543411858;15181.089134651957;15185.544433667008;15565.610859728597;15615;15726.13506257144;15780.763288550681;15793;6240.563160578807;6258.061290806416;6290.622562646256;6305.013920615083;6355.936440635627;1112.1769890281134;1117.3128525956479;1130.9434528273553;1135.2904434728296;1136.3068528197794;25418.110366137465;25504.872475637872;25713.357166070997;25738.356541086247;25799.226023219333;1211.7515909238584;1252.3550371558654;1253.473541112735;1257.6038547857395;1257.6415721519322;13646.113002654796;13705.383257753425;18485;18541.738362784938;18603.953565107826;309983;311186;312396;313685;314561;68323.65838170778;68818.65590672115;68944.3105568948;68997;69326.65336673285;1619.3522590963473;1654.9420770272982;1664.25108701085;1678.3789997700928;1679.1780917704427;30846.537301940938;31365.843170784;31658.525122123647;31719.841400792848;32245.67754322427;43673.34489982716;43677;43745;43746.781266093465;43893.34159987539;276319;276920;279708;280190;280678;38070.428943566425;38752.80623596864;39522.40716389199;42109.78945105255;42649.147017058865;52410.47589524056;52610.21084683656;53192.2021169675;53371;54231.72884135554;38072.23855522929;38141;38192.23615527729;38457.42313865238;39001.02497437587;37575.624243757215;37689.246215075;37752.433713494866;38311.80844095762;38388.040298992746;44226;44710.3293450592;45196.322055169854;45301.546984529734;45983.31025034694;35891.282174355845;36457.817710912335;36664.08339791527;36748.26503469969;36942;27497.31256718598;28035.71964280331;28191.71808281891;28235.71764282413;28679.139625811258 15:34:08 INFO - PID 9078 | |2;jquery.html;609.4484491535161;616.4113271825407;617.7343742190856;623.4700504571115;632.3739497897081;22220.8888955555;24422.511549768995;25193.118240861575;25328.74671253287;25342.87328563357;20072.698909516334;20503.282385116523;28324;28338.574921376196;28521.42957140861;6546.279909209983;6759.864802703943;6775.559588626748;6780.423663988567;6791.76228831991;6629.33706629338;6700.3969642732145;6715.3620406061345;6941.548799328053;6984.196817366017;6981.301869813029;6982.930170698304;6991.650417479131;6992.370686638202;6994.545354551938;6924.896126558106;6935.653217339138;6954.617496037716;6967.268436814113;6980.650967451607;6794.490413218979;6808.11494505716;6816.591004539743;6817.420519255869;6832.145981752281;34098.829505852314;34742;34938.47592286118;34973;35009;2320.211128216398;2327.6973993380752;2350.17743789674;2351.917682881091;2354;21278.51050426471;21460.141594336208;21816.236431724814;21961.01175447109;22240.88879555592;2540.6062060380486;2600.6099085137193;2601.856897870616;2616.4243866349375;2624.0291092295784;136894;143490;162043;162339;168028.15985920114;21910;23060.76939230586;24619.091418059535;25594.74405255961;26247;48421.5157848417;48951.75524122428;49142.52572422833;49266;49513.25730113979;11753.764924701458;11860.822087668692;12017.33904635236;12166.57416990401;12255.877441225652;9879.06148915852;9899.455529945779;9963.501824908726;9991.550380232908;10002.249831262685;12565.685857853627;12959.740805184032;12990.870091298966;13204.019397090513;13379.13035652699;4370.213361594943;4627.329037289574;4633.791479383436;4745.952540474551;4862.367892173995;1068.4871261794226;1069.9933187742467;1080.1844607321423;1080.1952545353604;1084.2843723142846;22252.221172258895;22471.775282247294;22479.21322753696;22547.323580292617;22839.647533230316;1144.9942750286195;1147.2428197389684;1157.9305241685527;1166.7083229192701;1172.5485688010178;11936;12326.630201093982;12344.691382715504;12446.751064978649;12466.252024878355;583524;595968;603533;623881;626282;125849.37075314565;126450;126834.99999999815;127238;127574.36212819062;1180.9055275577932;1248.3695733654629;1274.7131895323478;1304.9608511744664;1353.2827601371487;23031.309060728207;23594.882025589763;23602.881985589964;23631.291061268188;23682.289531314087;60251.384916905125;60411;61036.69481652563;61477.69261153666;62304.376956229855;76334;76761.61619191869;76960.23039769531;77232;77488.61255693912;22241.666375004064;22249.666255005865;22515.88742056345;22528.32415027552;22872.542549149257;25335;25646.87176564105;25658;25768.484630306913;26106.477870442865;20529.58940821205;20794.48013799667;21086.945652717608;21752.56494870062;22160;19186;19247.615047698688;19278.13248403797;20165.79834201698;20452.284170053976;22285;22745.09019639196;22904.198353057564;22954.655680164477;23034;22943.082276708745;23350.76649233554;23451.29646110551;23457.178998734962;23613.055477780697;20742.896285518476;21061.684074738583;21088.261910833047;21563.784362156177;21572.244971425924 15:34:08 INFO - PID 9078 | |3;mootools.html;1440.6326386771373;1499.6250937265684;1516.1433789908695;1519.6504803895104;1539.4227164813194;15743.60640983976;15966.7604985925;16309.347626094957;16337.591560211;16393.754093688603;16064.678706425864;16931.746023809654;16938.3224671013;16941.3223471061;16946.661066778688;2943;3008.3983203359307;3057.2509735114927;3061.3571150058515;3062.0354588304726;2966.2139533023765;3037.5595538646885;3063.035143929666;3067.662557118715;3076.138681169276;2986.1340211338684;2999.805012674169;3008.74425673818;3009.5184770436736;3010.08192501287;2940.1326608650497;2966.5698473721404;2971.0641148038408;2971.1680729395803;2973.122928736028;2903.056506635331;2945.9263518412;2972.2420782700274;2985.4029194161253;2987.268119310761;15915.204239787965;16020.35918563256;16066;16080.758788618181;16112.355505779755;8013.19868013194;8237.917620823775;8241.217084376975;8245.876311855327;8252.669893204265;5505.862353441156;5680.289963754531;5818.679972601505;5856.385079566627;5862.736176872051;1842.3459671816447;1903.0770076513018;1903.6192761447767;1938.903054847252;1944.7666280046344;28266.717332826614;28338;28338.858305708338;28425.57361639577;28491.57262641062;7505.174430812606;7512.661930213154;7574.5833979130575;7582.279683430065;7702.614869256515;18835.529111772314;18988.905055474912;19016.42950711453;19054.80945190558;19063.237470501026;8302.377321700777;8428.8314233715;8455.154484551618;8467.915320846836;8477.152284771597;7564.432667549956;7659.195784442665;7735.6905723770415;7762.534247945028;7765;5764.913526297109;5920.111983202468;5962.582619216613;6034.306054803666;6065.150878876961;1613.9677206455806;1659.336265493788;1723.3451288510287;1736.6266252755718;1764.876458647908;971.4851128901694;971.99028009719;977.4282045003611;985.192142443204;986.2898712926825;9177.449353038839;9516.666916657883;9576.808463830825;9578;9580.13778759901;1026.3636545341787;1051.400701600096;1069.0859315285475;1073.6725298783947;1076.1229597877705;5834.066549352084;5867.413258674099;5918.408159184133;5930.05119180929;6018.488428483541;22232.888835555717;23185.188518401774;23243;23512.882435588053;23540.64689029666;22401.66397504006;22964;23166.3050108497;23314.300570982898;23439;12631.87368126307;12743.68140796469;12933.254010708622;12936;12957.157784743962;9031.909680903107;9353.158215760614;9414.388064775767;9435;9453.43279403238;19714.014299285267;19877.204911803365;20249.898750506152;20364.79635203629;20550.794492055487;21123.683144752533;21124.366269011953;21219.045142968294;21313.360599182048;21445.892770536047;12048.638540843789;12125;12269.263844169378;12309.630711078682;12320.691982700504;14586.635334116732;14658.780118298448;14743.483978061146;14755.409783608535;14763.409463621334;10239.692809215736;11658;11712.121590880548;11754;11994;12042.578509752117;12077;12159.270443773403;12182.329971851634;12188.939055304667;11444.370559618968;11531.538738450368;11627.895349941742;11637.650870473899;11655.941720291345;7906.881396779168;7928.286454219148;7993.720219792512;8048.315893149148;8111.1888811118415;8286.212809783061;8316;8319.334453243606;8356.080831108695;8417.07412184647 15:34:08 INFO - PID 9078 | |4;prototype.html;534.6524758906712;543.4348277791099;559.2617744577158;564.9237352957349;574.253470488365;6170.444659980601;6208.161898143755;6290.685465726719;6294.43350098491;6317.77887773928;5936.732847021884;6073.301570319414;6105.54208434367;6135.447809697126;6179.486025923644;4864.054378248694;4880.463149053601;4902.436219834729;4905.82829600964;4948.480409556999;4762.952370476286;4836.250381190921;4837.879053023685;4854.296127061574;4865.318855360235;4795.832145874895;4808.591269742076;4828.637852161084;4836.081144582536;4907.803687852482;4811.494793046732;4857.63567732418;4890.70655760652;4917.508249175072;4937.136001199811;4434.1131773645075;4434.756088415136;4462.687611867171;4472.865814025585;4476.440444944382;6004.429579190014;6022.849428764316;6053.969730151321;6078.696065196723;6079.787207447718;5840.094785308242;5853.385394533555;5862.472377486004;5893.764249430018;5915.497182739472;6572.309907459696;6583.177102862142;6644.767433139865;6661.700968311181;6669.1330127083165;5035.471275516092;5075.670081444694;5090.694558326475;5097.209932460474;5097.617678674077;6938.132733408324;7000.824979375506;7001.36987671112;7019.754308599175;7065.752698655574;5166;5174.793008279702;5199.088510434169;5213;5245.396779370345;5225.372955245395;5246.580273578104;5260.947390526122;5293.497117773805;5297.576193904479;5770.913436298459;5864.677442740605;5885.234919460443;5896.911546326808;5897.675627840425;6532.477401807844;6629.635370054693;6629.668516574152;6640.236372817091;6641.634710090895;1759.8592112630959;1804.4586624012743;1809.3667216474128;1822.8450581700438;1834.4313262888547;1294.132930936275;1297.4420998970345;1312.6324629103867;1314.086709736743;1326.5754958413409;6365.840853978688;6380.457661098766;6382.8723425531225;6410.839729006812;6438.356164383524;6624.635645039569;6628.370304821035;6671.899921501182;6674.966625166843;6754.0881980931945;6346.397092276318;6369.14016607752;6428.421442070143;6469.935300646934;6496.740130394825;3498.8775392861126;3588.551431071116;3615.349237137288;3642.508261384732;3658.2074783355965;6996.125484314461;7046.189688185924;7082.752103676346;7089.865621500535;7098.3256590623805;6885.690143943534;6942.826429339307;6998.145491444771;7028.367446929801;7056.765066113409;6978.092847929838;6999.9350191693575;7014.298570143149;7061.82345441368;7078.327558881898;6742.292059333699;6760.729570817112;6819.89770153458;6829.419499342612;6898.585789913156;6724.293949135466;6729.394354508117;6752.459803215829;6764.188297404343;6816.727330906709;7048.471364647569;7048.612326322102;7113.786586402416;7117.3238542338395;7159.534630249017;5224.190250511177;5249.89500209986;5251.2123181523075;5255.500727430888;5278.683279003272;6618.305077966937;6766.966165169143;6884.4148247397525;6910.861782764216;6916.515843890879;6492.675366231575;6533.216014078341;6605.603663780189;6618.371254730793;6686.765963191459;6537.182852143482;6537.8692426152165;6561.442277406474;6575.572587781779;6664.366885145903;6445.291017987924;6570.277269500447;6594.802155935329;6658.503061351993;6660.83347916306;6611.702473388613;6658.267590565131;6677.131972843499;6689.531732778853;6732.192136943598;6432.260290066515;6452.935470645233;6457.160569125984;6501.1548498694865;6510.479161666961 15:34:08 INFO - PID 9078 | |5;yui.html;949.7103383468044;962.6390103711109;981.0483830684238;995.4525011243815;996.4419924842089;19260.807391926075;19902.40292791215;19980.40058798235;20016.799832001674;21705.131794728233;19438.611227775473;19491.902540487314;19505.804941950577;19521.316753913616;19625.214991400328;1040.8802987656402;1066.2589500297297;1074.8065348237315;1082.9187810914173;1083.214669364712;1100.1199040767394;1105.729096371386;1105.7788442311569;1105.8064838653245;1106.3583121789343;1070.0904231403322;1124.4939777100337;1129.0967226218993;1129.8079326514471;1132.5186795611874;1117.134220978744;1118.289885922437;1120.9047230985377;1123.584273818684;1126.4086354663784;817.7832874288318;819.1890028871434;819.9959000205021;820.729159377404;822.5599304372192;19990.100445479988;20063.097160627807;20216.292429764886;20312.08595613201;21063.684044739188;21003.474913127142;21166.78833211679;21352.679709804364;21595.892020539955;21620.89189554058;16117.274722637509;16171.191440428049;16173.595660108474;16204.189790510427;16599;3841.5390153181797;3846.115393459492;3865.9226815463535;3867.613238676138;3868.32304346741;151584.24207879;151776;152138;152675;153628;15541.922290388477;16862.40981565664;16935;17105.828941710424;17142.40001599963;32298.90057146278;32708.018759437255;32713.34573308568;33224.335513289596;33236.66763332384;7979;9510.191633711074;9689.224862011022;9714.514274286257;9720.75698107553;4283.993261583525;4621.168189725814;4726.740029298353;4752.239641657318;4778.187708089633;5825.155352473867;5913.438223368859;5931.021381472009;5931.258592675916;5957.434043765836;1167.2762887010108;1190.6428071578491;1197.6826141072622;1200.8078707406773;1205.421397729095;746.7983644415978;750.0586763611741;757.1217387830201;764.1746913333586;765.9195784442664;12735;12740.745185096246;12796.808047879289;13224.537141200011;13231.073824832169;729.919708832028;741.4253953186216;744.985100297991;748.8726916424221;750.5609218607176;6184.907226391608;6329.1139240505445;6420.74317027323;6437.903431448532;6451.741930322828;124362;128725;130293;130902;132242;108252;108832;112942;114117.4294128524;114358;99218.00781992232;99944;101273.49363253136;102269.48865255478;103879.48060259651;13066.150700204456;13210.273434960785;13402.93298533501;13547.119437236548;13729.97711670506;44217.673469795955;46424.53575464202;46709;48660.51339486701;48760.96244659406;84569;84660;87560.5621971886;87561.56219218863;88243;20749.79250207539;20944.47638809042;21063.78936210618;22130.557388851812;22132.778672213073;15974.760378594097;16858.662826743643;18812.341568045053;22628.547429051658;23722.644160337954;19734.60530789405;20119.39641810748;21325.146994120063;21510.569788604455;21893.671594926407;20141.49646258855;20687.482812929797;21185.682214767097;21720.23979160722;22042.669359959935;20448.079836407695;20673;20760.792392075888;20816.27143049986;21034.894825526386;13424.194548327132;13763.724725505233;13771.242581657703;13851.792223116863;13871.306434678427;15649.374025039326;15773.816963727537;15843.366265349718;15899.841001589835;16383.180840957666 15:34:08 INFO - PID 9078 | __end_tp_report 15:34:08 INFO - PID 9078 | __start_cc_report 15:34:08 INFO - PID 9078 | _x_x_mozilla_cycle_collect,297 15:34:08 INFO - PID 9078 | __end_cc_report 15:34:08 INFO - PID 9078 | __startTimestamp1505774048801__endTimestamp 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | ------- Summary: start ------- 15:34:08 INFO - PID 9078 | Number of tests: 6 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | [#0] dojo.html Cycles:165 Average:6344.00 Median:6646.83 stddev:808.06 (12.2%) stddev-sans-first:780.35 15:34:08 INFO - PID 9078 | Values: 3554.8 3573.7 3610.3 3615.0 3631.5 6335.0 6385.5 6401.0 6423.2 6468.9 6311.0 6340.8 6449.6 6450.0 6459.3 5443.2 5524.1 5531.3 5592.4 5607.0 5588.1 5620.1 5626.3 5629.6 5662.3 5595.7 5605.2 5620.4 5670.6 5688.5 5547.4 5597.0 5621.1 5631.3 5631.6 5497.5 5525.3 5545.5 5565.7 5574.5 6211.0 6241.3 6254.0 6292.6 6309.9 6718.9 6766.6 6777.5 6782.5 6785.2 6854.9 6928.5 6936.3 6961.4 7005.9 6405.9 6420.3 6463.5 6472.5 6497.4 6909.7 6991.3 6991.3 7010.4 7061.8 6764.2 6787.2 6799.8 6843.8 6853.4 6888.6 6922.5 7008.8 7009.8 7013.9 6874.9 6884.9 6891.8 6965.5 6969.3 6677.3 6798.4 6838.9 6869.1 6945.9 5140.4 5143.4 5149.2 5155.0 5155.7 4443.2 4533.7 4578.1 4578.8 4584.7 6506.8 6578.4 6588.7 6658.5 6662.3 6958.2 6971.7 6978.7 6988.0 7007.9 6492.0 6500.6 6545.0 6556.1 6570.8 5618.2 5648.3 5657.2 5733.8 5745.1 7197.3 7253.0 7256.7 7262.4 7286.4 6871.1 6890.3 6901.6 6973.4 6982.7 7023.4 7162.2 7166.0 7276.7 7278.7 6739.7 6843.5 6858.8 6867.0 6884.6 6985.9 6997.6 7049.7 7064.7 7067.2 6714.5 6722.0 6726.6 6811.9 6811.9 6571.9 6635.6 6638.2 6640.0 6646.8 6656.8 6685.9 6729.5 6764.4 6782.9 6670.3 6753.2 6803.8 6805.0 6838.9 6301.2 6435.5 6488.1 6526.9 6619.1 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | [#1] ext.html Cycles:180 Average:46303.88 Median:38876.92 stddev:71597.95 (184.2%) stddev-sans-first:71717.64 15:34:08 INFO - PID 9078 | Values: 900.3 907.4 941.9 948.7 955.9 44561.8 45356.0 45488.5 45529.3 45555.5 41723.6 41770.4 42204.8 42294.6 42359.6 7153.0 7320.3 7321.8 7329.9 7332.6 7224.7 7310.4 7311.8 7318.9 7320.4 7988.4 8119.8 8176.6 8180.6 8185.8 8045.6 8105.0 8117.3 8120.5 8121.1 7860.8 7872.8 7907.6 7947.5 7948.2 42751.1 42839.9 42852.4 42876.0 42880.8 3788.2 3796.2 3799.7 3823.4 3826.0 33429.0 33474.7 33475.5 33598.0 33604.0 5254.7 5273.1 5276.4 5277.2 5293.0 220909.0 222210.0 227668.0 229046.0 229616.0 53828.0 54456.5 54613.5 54687.5 54777.5 57107.7 57583.1 57712.7 57776.4 57919.7 18204.2 18323.4 18326.3 18327.3 18329.6 15145.0 15155.1 15163.8 15181.1 15185.5 15565.6 15615.0 15726.1 15780.8 15793.0 6240.6 6258.1 6290.6 6305.0 6355.9 1112.2 1117.3 1130.9 1135.3 1136.3 25418.1 25504.9 25713.4 25738.4 25799.2 1211.8 1252.4 1253.5 1257.6 1257.6 13646.1 13705.4 18485.0 18541.7 18604.0 309983.0 311186.0 312396.0 313685.0 314561.0 68323.7 68818.7 68944.3 68997.0 69326.7 1619.4 1654.9 1664.3 1678.4 1679.2 30846.5 31365.8 31658.5 31719.8 32245.7 43673.3 43677.0 43745.0 43746.8 43893.3 276319.0 276920.0 279708.0 280190.0 280678.0 38070.4 38752.8 39522.4 42109.8 42649.1 52410.5 52610.2 53192.2 53371.0 54231.7 38072.2 38141.0 38192.2 38457.4 39001.0 37575.6 37689.2 37752.4 38311.8 38388.0 44226.0 44710.3 45196.3 45301.5 45983.3 35891.3 36457.8 36664.1 36748.3 36942.0 27497.3 28035.7 28191.7 28235.7 28679.1 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | [#2] jquery.html Cycles:180 Average:41758.59 Median:12974.44 stddev:101196.26 (780.0%) stddev-sans-first:101432.98 15:34:08 INFO - PID 9078 | Values: 609.4 616.4 617.7 623.5 632.4 22220.9 24422.5 25193.1 25328.7 25342.9 20072.7 20503.3 28324.0 28338.6 28521.4 6546.3 6759.9 6775.6 6780.4 6791.8 6629.3 6700.4 6715.4 6941.5 6984.2 6981.3 6982.9 6991.7 6992.4 6994.5 6924.9 6935.7 6954.6 6967.3 6980.7 6794.5 6808.1 6816.6 6817.4 6832.1 34098.8 34742.0 34938.5 34973.0 35009.0 2320.2 2327.7 2350.2 2351.9 2354.0 21278.5 21460.1 21816.2 21961.0 22240.9 2540.6 2600.6 2601.9 2616.4 2624.0 136894.0 143490.0 162043.0 162339.0 168028.2 21910.0 23060.8 24619.1 25594.7 26247.0 48421.5 48951.8 49142.5 49266.0 49513.3 11753.8 11860.8 12017.3 12166.6 12255.9 9879.1 9899.5 9963.5 9991.6 10002.2 12565.7 12959.7 12990.9 13204.0 13379.1 4370.2 4627.3 4633.8 4746.0 4862.4 1068.5 1070.0 1080.2 1080.2 1084.3 22252.2 22471.8 22479.2 22547.3 22839.6 1145.0 1147.2 1157.9 1166.7 1172.5 11936.0 12326.6 12344.7 12446.8 12466.3 583524.0 595968.0 603533.0 623881.0 626282.0 125849.4 126450.0 126835.0 127238.0 127574.4 1180.9 1248.4 1274.7 1305.0 1353.3 23031.3 23594.9 23602.9 23631.3 23682.3 60251.4 60411.0 61036.7 61477.7 62304.4 76334.0 76761.6 76960.2 77232.0 77488.6 22241.7 22249.7 22515.9 22528.3 22872.5 25335.0 25646.9 25658.0 25768.5 26106.5 20529.6 20794.5 21086.9 21752.6 22160.0 19186.0 19247.6 19278.1 20165.8 20452.3 22285.0 22745.1 22904.2 22954.7 23034.0 22943.1 23350.8 23451.3 23457.2 23613.1 20742.9 21061.7 21088.3 21563.8 21572.2 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | [#3] mootools.html Cycles:180 Average:10157.19 Median:28302.36 stddev:7177.67 (25.4%) stddev-sans-first:7167.93 15:34:08 INFO - PID 9078 | Values: 1440.6 1499.6 1516.1 1519.7 1539.4 15743.6 15966.8 16309.3 16337.6 16393.8 16064.7 16931.7 16938.3 16941.3 16946.7 2943.0 3008.4 3057.3 3061.4 3062.0 2966.2 3037.6 3063.0 3067.7 3076.1 2986.1 2999.8 3008.7 3009.5 3010.1 2940.1 2966.6 2971.1 2971.2 2973.1 2903.1 2945.9 2972.2 2985.4 2987.3 15915.2 16020.4 16066.0 16080.8 16112.4 8013.2 8237.9 8241.2 8245.9 8252.7 5505.9 5680.3 5818.7 5856.4 5862.7 1842.3 1903.1 1903.6 1938.9 1944.8 28266.7 28338.0 28338.9 28425.6 28491.6 7505.2 7512.7 7574.6 7582.3 7702.6 18835.5 18988.9 19016.4 19054.8 19063.2 8302.4 8428.8 8455.2 8467.9 8477.2 7564.4 7659.2 7735.7 7762.5 7765.0 5764.9 5920.1 5962.6 6034.3 6065.2 1614.0 1659.3 1723.3 1736.6 1764.9 971.5 972.0 977.4 985.2 986.3 9177.4 9516.7 9576.8 9578.0 9580.1 1026.4 1051.4 1069.1 1073.7 1076.1 5834.1 5867.4 5918.4 5930.1 6018.5 22232.9 23185.2 23243.0 23512.9 23540.6 22401.7 22964.0 23166.3 23314.3 23439.0 12631.9 12743.7 12933.3 12936.0 12957.2 9031.9 9353.2 9414.4 9435.0 9453.4 19714.0 19877.2 20249.9 20364.8 20550.8 21123.7 21124.4 21219.0 21313.4 21445.9 12048.6 12125.0 12269.3 12309.6 12320.7 14586.6 14658.8 14743.5 14755.4 14763.4 10239.7 11658.0 11712.1 11754.0 11994.0 12042.6 12077.0 12159.3 12182.3 12188.9 11444.4 11531.5 11627.9 11637.7 11655.9 7906.9 7928.3 7993.7 8048.3 8111.2 8286.2 8316.0 8319.3 8356.1 8417.1 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | [#4] prototype.html Cycles:180 Average:5646.76 Median:6356.12 stddev:1597.46 (25.1%) stddev-sans-first:1555.18 15:34:08 INFO - PID 9078 | Values: 534.7 543.4 559.3 564.9 574.3 6170.4 6208.2 6290.7 6294.4 6317.8 5936.7 6073.3 6105.5 6135.4 6179.5 4864.1 4880.5 4902.4 4905.8 4948.5 4763.0 4836.3 4837.9 4854.3 4865.3 4795.8 4808.6 4828.6 4836.1 4907.8 4811.5 4857.6 4890.7 4917.5 4937.1 4434.1 4434.8 4462.7 4472.9 4476.4 6004.4 6022.8 6054.0 6078.7 6079.8 5840.1 5853.4 5862.5 5893.8 5915.5 6572.3 6583.2 6644.8 6661.7 6669.1 5035.5 5075.7 5090.7 5097.2 5097.6 6938.1 7000.8 7001.4 7019.8 7065.8 5166.0 5174.8 5199.1 5213.0 5245.4 5225.4 5246.6 5260.9 5293.5 5297.6 5770.9 5864.7 5885.2 5896.9 5897.7 6532.5 6629.6 6629.7 6640.2 6641.6 1759.9 1804.5 1809.4 1822.8 1834.4 1294.1 1297.4 1312.6 1314.1 1326.6 6365.8 6380.5 6382.9 6410.8 6438.4 6624.6 6628.4 6671.9 6675.0 6754.1 6346.4 6369.1 6428.4 6469.9 6496.7 3498.9 3588.6 3615.3 3642.5 3658.2 6996.1 7046.2 7082.8 7089.9 7098.3 6885.7 6942.8 6998.1 7028.4 7056.8 6978.1 6999.9 7014.3 7061.8 7078.3 6742.3 6760.7 6819.9 6829.4 6898.6 6724.3 6729.4 6752.5 6764.2 6816.7 7048.5 7048.6 7113.8 7117.3 7159.5 5224.2 5249.9 5251.2 5255.5 5278.7 6618.3 6767.0 6884.4 6910.9 6916.5 6492.7 6533.2 6605.6 6618.4 6686.8 6537.2 6537.9 6561.4 6575.6 6664.4 6445.3 6570.3 6594.8 6658.5 6660.8 6611.7 6658.3 6677.1 6689.5 6732.2 6432.3 6452.9 6457.2 6501.2 6510.5 15:34:08 INFO - PID 9078 | 15:34:08 INFO - PID 9078 | [#5] yui.html Cycles:180 Average:27059.08 Median:20264.19 stddev:38285.79 (188.9%) stddev-sans-first:38342.99 15:34:08 INFO - PID 9078 | Values: 949.7 962.6 981.0 995.5 996.4 19260.8 19902.4 19980.4 20016.8 21705.1 19438.6 19491.9 19505.8 19521.3 19625.2 1040.9 1066.3 1074.8 1082.9 1083.2 1100.1 1105.7 1105.8 1105.8 1106.4 1070.1 1124.5 1129.1 1129.8 1132.5 1117.1 1118.3 1120.9 1123.6 1126.4 817.8 819.2 820.0 820.7 822.6 19990.1 20063.1 20216.3 20312.1 21063.7 21003.5 21166.8 21352.7 21595.9 21620.9 16117.3 16171.2 16173.6 16204.2 16599.0 3841.5 3846.1 3865.9 3867.6 3868.3 151584.2 151776.0 152138.0 152675.0 153628.0 15541.9 16862.4 16935.0 17105.8 17142.4 32298.9 32708.0 32713.3 33224.3 33236.7 7979.0 9510.2 9689.2 9714.5 9720.8 4284.0 4621.2 4726.7 4752.2 4778.2 5825.2 5913.4 5931.0 5931.3 5957.4 1167.3 1190.6 1197.7 1200.8 1205.4 746.8 750.1 757.1 764.2 765.9 12735.0 12740.7 12796.8 13224.5 13231.1 729.9 741.4 745.0 748.9 750.6 6184.9 6329.1 6420.7 6437.9 6451.7 124362.0 128725.0 130293.0 130902.0 132242.0 108252.0 108832.0 112942.0 114117.4 114358.0 99218.0 99944.0 101273.5 102269.5 103879.5 13066.2 13210.3 13402.9 13547.1 13730.0 44217.7 46424.5 46709.0 48660.5 48761.0 84569.0 84660.0 87560.6 87561.6 88243.0 20749.8 20944.5 21063.8 22130.6 22132.8 15974.8 16858.7 18812.3 22628.5 23722.6 19734.6 20119.4 21325.1 21510.6 21893.7 20141.5 20687.5 21185.7 21720.2 22042.7 20448.1 20673.0 20760.8 20816.3 21034.9 13424.2 13763.7 13771.2 13851.8 13871.3 15649.4 15773.8 15843.4 15899.8 16383.2 15:34:08 INFO - PID 9078 | -------- Summary: end -------- 15:34:08 INFO - PID 9078 | 15:34:09 INFO - TEST-INFO | 9078: exit 0 15:34:09 INFO - TEST-OK | dromaeo_css | took 1108724ms 15:34:09 INFO - TEST-START | kraken 15:34:09 INFO - Initialising browser for kraken test... 15:34:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45270/getInfo.html -profile /tmp/tmpsnRl8K/profile 15:34:09 INFO - TEST-INFO | started process 9434 (/builds/slave/test/build/application/firefox/firefox http://localhost:45270/getInfo.html) 15:34:15 INFO - TEST-INFO | 9434: exit 0 15:34:15 INFO - Browser initialized. 15:34:15 INFO - Running cycle 1/1 for kraken test... 15:34:15 INFO - TEST-INFO | started process 9599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsnRl8K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:26 INFO - PID 9599 | RSS: Main: 151470080 15:34:26 INFO - PID 9599 | 15:34:28 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45270/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:29 INFO - PID 9599 | RSS: Main: 157941760 15:34:29 INFO - PID 9599 | 15:34:32 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45270/tests/kraken/driver.html?testName=audio-dft) 15:34:32 INFO - PID 9599 | RSS: Main: 159092736 15:34:32 INFO - PID 9599 | 15:34:35 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45270/tests/kraken/driver.html?testName=audio-fft) 15:34:36 INFO - PID 9599 | RSS: Main: 159277056 15:34:36 INFO - PID 9599 | 15:34:38 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45270/tests/kraken/driver.html?testName=audio-oscillator) 15:34:39 INFO - PID 9599 | RSS: Main: 158650368 15:34:39 INFO - PID 9599 | 15:34:41 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:41 INFO - PID 9599 | RSS: Main: 159260672 15:34:41 INFO - PID 9599 | 15:34:44 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45270/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:45 INFO - PID 9599 | RSS: Main: 158539776 15:34:45 INFO - PID 9599 | 15:34:48 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45270/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:49 INFO - PID 9599 | RSS: Main: 161927168 15:34:49 INFO - PID 9599 | 15:34:52 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45270/tests/kraken/driver.html?testName=json-parse-financial) 15:34:52 INFO - PID 9599 | RSS: Main: 162316288 15:34:52 INFO - PID 9599 | 15:34:54 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:54 INFO - PID 9599 | RSS: Main: 162275328 15:34:54 INFO - PID 9599 | 15:34:56 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:34:57 INFO - PID 9599 | RSS: Main: 162287616 15:34:57 INFO - PID 9599 | 15:34:59 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:34:59 INFO - PID 9599 | RSS: Main: 162594816 15:34:59 INFO - PID 9599 | 15:35:02 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:03 INFO - PID 9599 | RSS: Main: 162439168 15:35:03 INFO - PID 9599 | 15:35:05 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:06 INFO - PID 9599 | RSS: Main: 162570240 15:35:06 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | Cycle 1(1): loaded http://localhost:45270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45270/tests/kraken/driver.html?testName=ai-astar) 15:35:08 INFO - PID 9599 | RSS: Main: 163766272 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | __start_tp_report 15:35:08 INFO - PID 9599 | _x_x_mozilla_page_load 15:35:08 INFO - PID 9599 | _x_x_mozilla_page_load_details 15:35:08 INFO - PID 9599 | |i|pagename|runs| 15:35:08 INFO - PID 9599 | |0;ai-astar;97;106;106;106;107;113;106;100;106;109 15:35:08 INFO - PID 9599 | |1;audio-beat-detection;146;111;145;154;115;143;141;122;167;112 15:35:08 INFO - PID 9599 | |2;audio-dft;163;164;163;160;165;162;161;161;162;163 15:35:08 INFO - PID 9599 | |3;audio-fft;75;74;74;196;76;74;73;76;181;76 15:35:08 INFO - PID 9599 | |4;audio-oscillator;78;76;125;78;78;78;127;78;78;123 15:35:08 INFO - PID 9599 | |5;imaging-gaussian-blur;114;114;113;114;114;114;114;114;113;113 15:35:08 INFO - PID 9599 | |6;imaging-darkroom;148;147;148;147;148;148;147;149;149;147 15:35:08 INFO - PID 9599 | |7;imaging-desaturate;94;95;95;94;94;95;94;94;94;95 15:35:08 INFO - PID 9599 | |8;json-parse-financial;53;46;46;47;47;47;49;47;46;45 15:35:08 INFO - PID 9599 | |9;json-stringify-tinderbox;54;53;53;54;54;53;54;54;53;54 15:35:08 INFO - PID 9599 | |10;stanford-crypto-aes;72;73;73;72;73;73;78;72;74;72 15:35:08 INFO - PID 9599 | |11;stanford-crypto-ccm;115;124;114;112;117;121;115;112;122;141 15:35:08 INFO - PID 9599 | |12;stanford-crypto-pbkdf2;171;158;164;162;163;173;162;156;159;159 15:35:08 INFO - PID 9599 | |13;stanford-crypto-sha256-iterative;59;59;61;58;59;59;58;60;59;58 15:35:08 INFO - PID 9599 | __end_tp_report 15:35:08 INFO - PID 9599 | __start_cc_report 15:35:08 INFO - PID 9599 | _x_x_mozilla_cycle_collect,789 15:35:08 INFO - PID 9599 | __end_cc_report 15:35:08 INFO - PID 9599 | __startTimestamp1505774108426__endTimestamp 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | ------- Summary: start ------- 15:35:08 INFO - PID 9599 | Number of tests: 14 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.50 stddev:4.40 (4.1%) stddev-sans-first:3.40 15:35:08 INFO - PID 9599 | Values: 97.0 106.0 106.0 106.0 107.0 113.0 106.0 100.0 106.0 109.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:144.00 stddev:19.37 (13.5%) stddev-sans-first:20.17 15:35:08 INFO - PID 9599 | Values: 146.0 111.0 145.0 154.0 115.0 143.0 141.0 122.0 167.0 112.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 15:35:08 INFO - PID 9599 | Values: 163.0 164.0 163.0 160.0 165.0 162.0 161.0 161.0 162.0 163.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#3] audio-fft Cycles:10 Average:97.50 Median:74.50 stddev:48.10 (64.6%) stddev-sans-first:50.33 15:35:08 INFO - PID 9599 | Values: 75.0 74.0 74.0 196.0 76.0 74.0 73.0 76.0 181.0 76.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:78.00 stddev:22.87 (29.3%) stddev-sans-first:23.70 15:35:08 INFO - PID 9599 | Values: 78.0 76.0 125.0 78.0 78.0 78.0 127.0 78.0 78.0 123.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:35:08 INFO - PID 9599 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 15:35:08 INFO - PID 9599 | Values: 148.0 147.0 148.0 147.0 148.0 148.0 147.0 149.0 149.0 147.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:35:08 INFO - PID 9599 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#8] json-parse-financial Cycles:10 Average:47.30 Median:47.00 stddev:2.26 (4.8%) stddev-sans-first:1.12 15:35:08 INFO - PID 9599 | Values: 53.0 46.0 46.0 47.0 47.0 47.0 49.0 47.0 46.0 45.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 15:35:08 INFO - PID 9599 | Values: 54.0 53.0 53.0 54.0 54.0 53.0 54.0 54.0 53.0 54.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.81 (2.5%) stddev-sans-first:1.87 15:35:08 INFO - PID 9599 | Values: 72.0 73.0 73.0 72.0 73.0 73.0 78.0 72.0 74.0 72.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:119.00 stddev:8.69 (7.3%) stddev-sans-first:9.08 15:35:08 INFO - PID 9599 | Values: 115.0 124.0 114.0 112.0 117.0 121.0 115.0 112.0 122.0 141.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.50 stddev:5.50 (3.4%) stddev-sans-first:4.94 15:35:08 INFO - PID 9599 | Values: 171.0 158.0 164.0 162.0 163.0 173.0 162.0 156.0 159.0 159.0 15:35:08 INFO - PID 9599 | 15:35:08 INFO - PID 9599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.00 Median:59.00 stddev:0.94 (1.6%) stddev-sans-first:1.00 15:35:08 INFO - PID 9599 | Values: 59.0 59.0 61.0 58.0 59.0 59.0 58.0 60.0 59.0 58.0 15:35:08 INFO - PID 9599 | -------- Summary: end -------- 15:35:08 INFO - PID 9599 | 15:35:09 INFO - PID 9599 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:35:09 INFO - TEST-INFO | 9599: exit 0 15:35:09 INFO - TEST-OK | kraken | took 59873ms 15:35:09 INFO - SUITE-END | took 1168s 15:35:09 INFO - Completed test suite (00:19:28) 15:35:09 INFO - javascript benchmark 15:35:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9342.67814807574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3554.8222588870567, 3573.7141028717706, 3610.2598967211725, 3615.0, 3631.473436351729, 6335.049742538621, 6385.521085918557, 6400.967995160024, 6423.229212494495, 6468.902966455507, 6310.968445157768, 6340.841478963017, 6449.6130232186215, 6450.0324951257335, 6459.257185423666, 5443.237946687467, 5524.116141417374, 5531.2532808071, 5592.356878958911, 5607.046802043642, 5588.133839254922, 5620.1288800236025, 5626.2967129108865, 5629.60592758507, 5662.292213473316, 5595.664260144405, 5605.215269862222, 5620.381758006616, 5670.5747068969995, 5688.516476099537, 5547.417521160261, 5597.048501754671, 5621.072523033695, 5631.2960879890015, 5631.63394379364, 5497.45025497451, 5525.309336332958, 5545.500904918536, 5565.749541270652, 5574.526165275915, 6211.0, 6241.251049874044, 6253.968730156365, 6292.5595208335435, 6309.905351419732, 6718.932810671929, 6766.594004359754, 6777.491688123361, 6782.491313151533, 6785.1518560179975, 6854.862902741967, 6928.4803639726715, 6936.265933516621, 6961.37347638715, 7005.929940700578, 6405.935940640627, 6420.293767685551, 6463.450606698436, 6472.482201423922, 6497.415232629086, 6909.654517274116, 6991.265917078634, 6991.335823096798, 7010.369066784014, 7061.82345441368, 6764.154480689914, 6787.185537735503, 6799.796006119825, 6843.7604683835825, 6853.417459515997, 6888.621125838127, 6922.480813938974, 7008.754693585802, 7009.754658586925, 7013.929860701328, 6874.896876546856, 6884.896726549106, 6891.827704307332, 6965.477589180831, 6969.337912898267, 6677.265500794909, 6798.354156355237, 6838.863222735517, 6869.107016087976, 6945.89581156283, 5140.3831540215415, 5143.382794064736, 5149.150390185578, 5155.02054609623, 5155.690658560498, 4443.244648409778, 4533.682642215079, 4578.084383123389, 4578.816847326137, 4584.701994370355, 6506.772262970868, 6578.440832529289, 6588.703508342041, 6658.4673226141795, 6662.300458451889, 6958.199807022156, 6971.65141742921, 6978.685959131852, 6987.965060174666, 7007.92992070083, 6492.0, 6500.642464664489, 6544.9672751635935, 6556.147700798866, 6570.77002304917, 5618.157276408571, 5648.322201335866, 5657.179708942181, 5733.827985160452, 5745.1382292656435, 7197.280271972761, 7253.020842186343, 7256.7460138894885, 7262.419006479469, 7286.380657644159, 6871.072405225231, 6890.31096890307, 6901.62041087745, 6973.372396484341, 6982.6508674567085, 7023.367896889305, 7162.176349719849, 7165.964170179116, 7276.745313913988, 7278.6724597392185, 6739.696713647995, 6843.486738494533, 6858.8285292866085, 6867.038614593861, 6884.586924784529, 6985.930140698528, 6997.580145191305, 7049.682764275723, 7064.682089305891, 7067.151941767021, 6714.496412769159, 6722.0, 6726.630035348103, 6811.863762724817, 6811.931880681328, 6571.901421478778, 6635.6350400728425, 6638.236602790741, 6640.037194606658, 6646.83382915431, 6656.7670131545165, 6685.8997115044285, 6729.461643068641, 6764.425023873026, 6782.864342713019, 6670.266270710315, 6753.15585551806, 6803.7618683345845, 6805.0472933788315, 6838.863222735617, 6301.180846489927, 6435.4529864962005, 6488.091667166506, 6526.902096468461, 6619.139511863427], "value": 6283.33681223448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.2617853360243, 907.3739120007194, 941.9434833909964, 948.7011591348729, 955.8518429643408, 44561.77719111404, 45356.0, 45488.54511454885, 45529.317060244124, 45555.54444455555, 41723.58276417235, 41770.373444398356, 42204.788976055075, 42294.57705422945, 42359.57640423595, 7153.0, 7320.267973202664, 7321.816954576151, 7329.853402931938, 7332.633368331589, 7224.674889629953, 7310.378617817492, 7311.780646580584, 7318.890216646754, 7320.414366850639, 7988.360931125525, 8119.797005074891, 8176.591170441484, 8180.590970451483, 8185.79535511611, 8045.557494337839, 8105.0, 8117.269445749911, 8120.512769233836, 8121.147279535623, 7860.842783144305, 7872.803179920491, 7907.565083920382, 7947.483413578099, 7948.244916732901, 42751.144977100594, 42839.85800709952, 42852.35721464181, 42876.0, 42880.785596072135, 3788.2234142000825, 3796.240751849641, 3799.734018618698, 3823.3691440912216, 3825.9808700956596, 33429.0, 33474.66101355943, 33475.49786753201, 33598.0, 33604.0, 5254.710990895499, 5273.1035723927025, 5276.445973172838, 5277.1820367842665, 5292.973535132338, 220909.0, 222210.0, 227668.0, 229045.99999999834, 229616.0, 53828.0, 54456.45543544593, 54613.45386546083, 54687.45312546903, 54777.45222547803, 57107.71446142826, 57583.13625295624, 57712.71143644255, 57776.42223577794, 57919.71040144772, 18204.180811863498, 18323.35868244605, 18326.266949322144, 18327.266909323476, 18329.633407331778, 15145.0, 15155.090694558361, 15163.772543411858, 15181.089134651957, 15185.544433667008, 15565.610859728597, 15615.0, 15726.13506257144, 15780.763288550681, 15793.0, 6240.563160578807, 6258.061290806416, 6290.622562646256, 6305.013920615083, 6355.936440635627, 1112.1769890281134, 1117.3128525956479, 1130.9434528273553, 1135.2904434728296, 1136.3068528197794, 25418.110366137465, 25504.872475637872, 25713.357166070997, 25738.356541086247, 25799.226023219333, 1211.7515909238584, 1252.3550371558654, 1253.473541112735, 1257.6038547857395, 1257.6415721519322, 13646.113002654796, 13705.383257753425, 18485.0, 18541.738362784938, 18603.953565107826, 309983.0, 311186.0, 312396.0, 313685.0, 314561.0, 68323.65838170778, 68818.65590672115, 68944.3105568948, 68997.0, 69326.65336673285, 1619.3522590963473, 1654.9420770272982, 1664.25108701085, 1678.3789997700928, 1679.1780917704427, 30846.537301940938, 31365.843170784, 31658.525122123647, 31719.841400792848, 32245.67754322427, 43673.34489982716, 43677.0, 43745.0, 43746.781266093465, 43893.34159987539, 276319.0, 276920.0, 279708.0, 280190.0, 280678.0, 38070.428943566425, 38752.80623596864, 39522.40716389199, 42109.78945105255, 42649.147017058865, 52410.47589524056, 52610.21084683656, 53192.2021169675, 53371.0, 54231.72884135554, 38072.23855522929, 38141.0, 38192.23615527729, 38457.42313865238, 39001.02497437587, 37575.624243757215, 37689.246215075, 37752.433713494866, 38311.80844095762, 38388.040298992746, 44226.0, 44710.3293450592, 45196.322055169854, 45301.546984529734, 45983.31025034694, 35891.282174355845, 36457.817710912335, 36664.08339791527, 36748.26503469969, 36942.0, 27497.31256718598, 28035.71964280331, 28191.71808281891, 28235.71764282413, 28679.139625811258], "value": 19592.164124600986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4484491535161, 616.4113271825407, 617.7343742190856, 623.4700504571115, 632.3739497897081, 22220.8888955555, 24422.511549768995, 25193.118240861575, 25328.74671253287, 25342.87328563357, 20072.698909516334, 20503.282385116523, 28324.0, 28338.574921376196, 28521.42957140861, 6546.279909209983, 6759.864802703943, 6775.559588626748, 6780.423663988567, 6791.76228831991, 6629.33706629338, 6700.3969642732145, 6715.3620406061345, 6941.548799328053, 6984.196817366017, 6981.301869813029, 6982.930170698304, 6991.650417479131, 6992.370686638202, 6994.545354551938, 6924.896126558106, 6935.653217339138, 6954.617496037716, 6967.268436814113, 6980.650967451607, 6794.490413218979, 6808.11494505716, 6816.591004539743, 6817.420519255869, 6832.145981752281, 34098.829505852314, 34742.0, 34938.47592286118, 34973.0, 35009.0, 2320.211128216398, 2327.6973993380752, 2350.17743789674, 2351.917682881091, 2354.0, 21278.51050426471, 21460.141594336208, 21816.236431724814, 21961.01175447109, 22240.88879555592, 2540.6062060380486, 2600.6099085137193, 2601.856897870616, 2616.4243866349375, 2624.0291092295784, 136894.0, 143490.0, 162043.0, 162339.0, 168028.15985920114, 21910.0, 23060.76939230586, 24619.091418059535, 25594.74405255961, 26247.0, 48421.5157848417, 48951.75524122428, 49142.52572422833, 49266.0, 49513.25730113979, 11753.764924701458, 11860.822087668692, 12017.33904635236, 12166.57416990401, 12255.877441225652, 9879.06148915852, 9899.455529945779, 9963.501824908726, 9991.550380232908, 10002.249831262685, 12565.685857853627, 12959.740805184032, 12990.870091298966, 13204.019397090513, 13379.13035652699, 4370.213361594943, 4627.329037289574, 4633.791479383436, 4745.952540474551, 4862.367892173995, 1068.4871261794226, 1069.9933187742467, 1080.1844607321423, 1080.1952545353604, 1084.2843723142846, 22252.221172258895, 22471.775282247294, 22479.21322753696, 22547.323580292617, 22839.647533230316, 1144.9942750286195, 1147.2428197389684, 1157.9305241685527, 1166.7083229192701, 1172.5485688010178, 11936.0, 12326.630201093982, 12344.691382715504, 12446.751064978649, 12466.252024878355, 583524.0, 595968.0, 603533.0, 623881.0, 626282.0, 125849.37075314565, 126450.0, 126834.99999999815, 127238.0, 127574.36212819062, 1180.9055275577932, 1248.3695733654629, 1274.7131895323478, 1304.9608511744664, 1353.2827601371487, 23031.309060728207, 23594.882025589763, 23602.881985589964, 23631.291061268188, 23682.289531314087, 60251.384916905125, 60411.0, 61036.69481652563, 61477.69261153666, 62304.376956229855, 76334.0, 76761.61619191869, 76960.23039769531, 77232.0, 77488.61255693912, 22241.666375004064, 22249.666255005865, 22515.88742056345, 22528.32415027552, 22872.542549149257, 25335.0, 25646.87176564105, 25658.0, 25768.484630306913, 26106.477870442865, 20529.58940821205, 20794.48013799667, 21086.945652717608, 21752.56494870062, 22160.0, 19186.0, 19247.615047698688, 19278.13248403797, 20165.79834201698, 20452.284170053976, 22285.0, 22745.09019639196, 22904.198353057564, 22954.655680164477, 23034.0, 22943.082276708745, 23350.76649233554, 23451.29646110551, 23457.178998734962, 23613.055477780697, 20742.896285518476, 21061.684074738583, 21088.261910833047, 21563.784362156177, 21572.244971425924], "value": 14269.715412026162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.6326386771373, 1499.6250937265684, 1516.1433789908695, 1519.6504803895104, 1539.4227164813194, 15743.60640983976, 15966.7604985925, 16309.347626094957, 16337.591560211, 16393.754093688603, 16064.678706425864, 16931.746023809654, 16938.3224671013, 16941.3223471061, 16946.661066778688, 2943.0, 3008.3983203359307, 3057.2509735114927, 3061.3571150058515, 3062.0354588304726, 2966.2139533023765, 3037.5595538646885, 3063.035143929666, 3067.662557118715, 3076.138681169276, 2986.1340211338684, 2999.805012674169, 3008.74425673818, 3009.5184770436736, 3010.08192501287, 2940.1326608650497, 2966.5698473721404, 2971.0641148038408, 2971.1680729395803, 2973.122928736028, 2903.056506635331, 2945.9263518412, 2972.2420782700274, 2985.4029194161253, 2987.268119310761, 15915.204239787965, 16020.35918563256, 16066.0, 16080.758788618181, 16112.355505779755, 8013.19868013194, 8237.917620823775, 8241.217084376975, 8245.876311855327, 8252.669893204265, 5505.862353441156, 5680.289963754531, 5818.679972601505, 5856.385079566627, 5862.736176872051, 1842.3459671816447, 1903.0770076513018, 1903.6192761447767, 1938.903054847252, 1944.7666280046344, 28266.717332826614, 28338.0, 28338.858305708338, 28425.57361639577, 28491.57262641062, 7505.174430812606, 7512.661930213154, 7574.5833979130575, 7582.279683430065, 7702.614869256515, 18835.529111772314, 18988.905055474912, 19016.42950711453, 19054.80945190558, 19063.237470501026, 8302.377321700777, 8428.8314233715, 8455.154484551618, 8467.915320846836, 8477.152284771597, 7564.432667549956, 7659.195784442665, 7735.6905723770415, 7762.534247945028, 7765.0, 5764.913526297109, 5920.111983202468, 5962.582619216613, 6034.306054803666, 6065.150878876961, 1613.9677206455806, 1659.336265493788, 1723.3451288510287, 1736.6266252755718, 1764.876458647908, 971.4851128901694, 971.99028009719, 977.4282045003611, 985.192142443204, 986.2898712926825, 9177.449353038839, 9516.666916657883, 9576.808463830825, 9578.0, 9580.13778759901, 1026.3636545341787, 1051.400701600096, 1069.0859315285475, 1073.6725298783947, 1076.1229597877705, 5834.066549352084, 5867.413258674099, 5918.408159184133, 5930.05119180929, 6018.488428483541, 22232.888835555717, 23185.188518401774, 23243.0, 23512.882435588053, 23540.64689029666, 22401.66397504006, 22964.0, 23166.3050108497, 23314.300570982898, 23439.0, 12631.87368126307, 12743.68140796469, 12933.254010708622, 12936.0, 12957.157784743962, 9031.909680903107, 9353.158215760614, 9414.388064775767, 9435.0, 9453.43279403238, 19714.014299285267, 19877.204911803365, 20249.898750506152, 20364.79635203629, 20550.794492055487, 21123.683144752533, 21124.366269011953, 21219.045142968294, 21313.360599182048, 21445.892770536047, 12048.638540843789, 12125.0, 12269.263844169378, 12309.630711078682, 12320.691982700504, 14586.635334116732, 14658.780118298448, 14743.483978061146, 14755.409783608535, 14763.409463621334, 10239.692809215736, 11658.0, 11712.121590880548, 11754.0, 11994.0, 12042.578509752117, 12077.0, 12159.270443773403, 12182.329971851634, 12188.939055304667, 11444.370559618968, 11531.538738450368, 11627.895349941742, 11637.650870473899, 11655.941720291345, 7906.881396779168, 7928.286454219148, 7993.720219792512, 8048.315893149148, 8111.1888811118415, 8286.212809783061, 8316.0, 8319.334453243606, 8356.080831108695, 8417.07412184647], "value": 7295.132243035357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.6524758906712, 543.4348277791099, 559.2617744577158, 564.9237352957349, 574.253470488365, 6170.444659980601, 6208.161898143755, 6290.685465726719, 6294.43350098491, 6317.77887773928, 5936.732847021884, 6073.301570319414, 6105.54208434367, 6135.447809697126, 6179.486025923644, 4864.054378248694, 4880.463149053601, 4902.436219834729, 4905.82829600964, 4948.480409556999, 4762.952370476286, 4836.250381190921, 4837.879053023685, 4854.296127061574, 4865.318855360235, 4795.832145874895, 4808.591269742076, 4828.637852161084, 4836.081144582536, 4907.803687852482, 4811.494793046732, 4857.63567732418, 4890.70655760652, 4917.508249175072, 4937.136001199811, 4434.1131773645075, 4434.756088415136, 4462.687611867171, 4472.865814025585, 4476.440444944382, 6004.429579190014, 6022.849428764316, 6053.969730151321, 6078.696065196723, 6079.787207447718, 5840.094785308242, 5853.385394533555, 5862.472377486004, 5893.764249430018, 5915.497182739472, 6572.309907459696, 6583.177102862142, 6644.767433139865, 6661.700968311181, 6669.1330127083165, 5035.471275516092, 5075.670081444694, 5090.694558326475, 5097.209932460474, 5097.617678674077, 6938.132733408324, 7000.824979375506, 7001.36987671112, 7019.754308599175, 7065.752698655574, 5166.0, 5174.793008279702, 5199.088510434169, 5213.0, 5245.396779370345, 5225.372955245395, 5246.580273578104, 5260.947390526122, 5293.497117773805, 5297.576193904479, 5770.913436298459, 5864.677442740605, 5885.234919460443, 5896.911546326808, 5897.675627840425, 6532.477401807844, 6629.635370054693, 6629.668516574152, 6640.236372817091, 6641.634710090895, 1759.8592112630959, 1804.4586624012743, 1809.3667216474128, 1822.8450581700438, 1834.4313262888547, 1294.132930936275, 1297.4420998970345, 1312.6324629103867, 1314.086709736743, 1326.5754958413409, 6365.840853978688, 6380.457661098766, 6382.8723425531225, 6410.839729006812, 6438.356164383524, 6624.635645039569, 6628.370304821035, 6671.899921501182, 6674.966625166843, 6754.0881980931945, 6346.397092276318, 6369.14016607752, 6428.421442070143, 6469.935300646934, 6496.740130394825, 3498.8775392861126, 3588.551431071116, 3615.349237137288, 3642.508261384732, 3658.2074783355965, 6996.125484314461, 7046.189688185924, 7082.752103676346, 7089.865621500535, 7098.3256590623805, 6885.690143943534, 6942.826429339307, 6998.145491444771, 7028.367446929801, 7056.765066113409, 6978.092847929838, 6999.9350191693575, 7014.298570143149, 7061.82345441368, 7078.327558881898, 6742.292059333699, 6760.729570817112, 6819.89770153458, 6829.419499342612, 6898.585789913156, 6724.293949135466, 6729.394354508117, 6752.459803215829, 6764.188297404343, 6816.727330906709, 7048.471364647569, 7048.612326322102, 7113.786586402416, 7117.3238542338395, 7159.534630249017, 5224.190250511177, 5249.89500209986, 5251.2123181523075, 5255.500727430888, 5278.683279003272, 6618.305077966937, 6766.966165169143, 6884.4148247397525, 6910.861782764216, 6916.515843890879, 6492.675366231575, 6533.216014078341, 6605.603663780189, 6618.371254730793, 6686.765963191459, 6537.182852143482, 6537.8692426152165, 6561.442277406474, 6575.572587781779, 6664.366885145903, 6445.291017987924, 6570.277269500447, 6594.802155935329, 6658.503061351993, 6660.83347916306, 6611.702473388613, 6658.267590565131, 6677.131972843499, 6689.531732778853, 6732.192136943598, 6432.260290066515, 6452.935470645233, 6457.160569125984, 6501.1548498694865, 6510.479161666961], "value": 5187.166864517889, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [949.7103383468044, 962.6390103711109, 981.0483830684238, 995.4525011243815, 996.4419924842089, 19260.807391926075, 19902.40292791215, 19980.40058798235, 20016.799832001674, 21705.131794728233, 19438.611227775473, 19491.902540487314, 19505.804941950577, 19521.316753913616, 19625.214991400328, 1040.8802987656402, 1066.2589500297297, 1074.8065348237315, 1082.9187810914173, 1083.214669364712, 1100.1199040767394, 1105.729096371386, 1105.7788442311569, 1105.8064838653245, 1106.3583121789343, 1070.0904231403322, 1124.4939777100337, 1129.0967226218993, 1129.8079326514471, 1132.5186795611874, 1117.134220978744, 1118.289885922437, 1120.9047230985377, 1123.584273818684, 1126.4086354663784, 817.7832874288318, 819.1890028871434, 819.9959000205021, 820.729159377404, 822.5599304372192, 19990.100445479988, 20063.097160627807, 20216.292429764886, 20312.08595613201, 21063.684044739188, 21003.474913127142, 21166.78833211679, 21352.679709804364, 21595.892020539955, 21620.89189554058, 16117.274722637509, 16171.191440428049, 16173.595660108474, 16204.189790510427, 16599.0, 3841.5390153181797, 3846.115393459492, 3865.9226815463535, 3867.613238676138, 3868.32304346741, 151584.24207879, 151776.0, 152138.0, 152675.0, 153628.0, 15541.922290388477, 16862.40981565664, 16935.0, 17105.828941710424, 17142.40001599963, 32298.90057146278, 32708.018759437255, 32713.34573308568, 33224.335513289596, 33236.66763332384, 7979.0, 9510.191633711074, 9689.224862011022, 9714.514274286257, 9720.75698107553, 4283.993261583525, 4621.168189725814, 4726.740029298353, 4752.239641657318, 4778.187708089633, 5825.155352473867, 5913.438223368859, 5931.021381472009, 5931.258592675916, 5957.434043765836, 1167.2762887010108, 1190.6428071578491, 1197.6826141072622, 1200.8078707406773, 1205.421397729095, 746.7983644415978, 750.0586763611741, 757.1217387830201, 764.1746913333586, 765.9195784442664, 12735.0, 12740.745185096246, 12796.808047879289, 13224.537141200011, 13231.073824832169, 729.919708832028, 741.4253953186216, 744.985100297991, 748.8726916424221, 750.5609218607176, 6184.907226391608, 6329.1139240505445, 6420.74317027323, 6437.903431448532, 6451.741930322828, 124362.0, 128725.0, 130293.0, 130902.0, 132242.0, 108252.0, 108832.0, 112942.0, 114117.4294128524, 114358.0, 99218.00781992232, 99944.0, 101273.49363253136, 102269.48865255478, 103879.48060259651, 13066.150700204456, 13210.273434960785, 13402.93298533501, 13547.119437236548, 13729.97711670506, 44217.673469795955, 46424.53575464202, 46709.0, 48660.51339486701, 48760.96244659406, 84569.0, 84660.0, 87560.5621971886, 87561.56219218863, 88243.0, 20749.79250207539, 20944.47638809042, 21063.78936210618, 22130.557388851812, 22132.778672213073, 15974.760378594097, 16858.662826743643, 18812.341568045053, 22628.547429051658, 23722.644160337954, 19734.60530789405, 20119.39641810748, 21325.146994120063, 21510.569788604455, 21893.671594926407, 20141.49646258855, 20687.482812929797, 21185.682214767097, 21720.23979160722, 22042.669359959935, 20448.079836407695, 20673.0, 20760.792392075888, 20816.27143049986, 21034.894825526386, 13424.194548327132, 13763.724725505233, 13771.242581657703, 13851.792223116863, 13871.306434678427, 15649.374025039326, 15773.816963727537, 15843.366265349718, 15899.841001589835, 16383.180840957666], "value": 10003.394625567034, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 106.0, 106.0, 107.0, 113.0, 106.0, 100.0, 106.0, 109.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 145.0, 154.0, 115.0, 143.0, 141.0, 122.0, 167.0, 112.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 160.0, 165.0, 162.0, 161.0, 161.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 196.0, 76.0, 74.0, 73.0, 76.0, 181.0, 76.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 125.0, 78.0, 78.0, 78.0, 127.0, 78.0, 78.0, 123.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 149.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 46.0, 46.0, 47.0, 47.0, 47.0, 49.0, 47.0, 46.0, 45.0], "value": 47.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 72.0, 73.0, 73.0, 78.0, 72.0, 74.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 114.0, 112.0, 117.0, 121.0, 115.0, 112.0, 122.0, 141.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 158.0, 164.0, 162.0, 163.0, 173.0, 162.0, 156.0, 159.0, 159.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 58.0, 59.0, 59.0, 58.0, 60.0, 59.0, 58.0], "value": 59.0, "unit": "score"}]}]} 15:35:09 INFO - Return code: 0 15:35:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:35:09 INFO - # TBPL SUCCESS # 15:35:09 INFO - Running post-action listener: _package_coverage_data 15:35:09 INFO - Running post-action listener: _resource_record_post_action 15:35:09 INFO - [mozharness: 2017-09-18 22:35:09.727235Z] Finished run-tests step (success) 15:35:09 INFO - Running post-run listener: _resource_record_post_run 15:35:09 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 577536; Write bytes: 356868096; Read time: 64; Write time: 274956 15:35:09 INFO - TinderboxPrint: CPU usage
13.0% 15:35:09 INFO - TinderboxPrint: I/O read bytes / time
577,536 / 64 15:35:09 INFO - TinderboxPrint: I/O write bytes / time
356,868,096 / 274,956 15:35:09 INFO - TinderboxPrint: CPU idle
8,207.9 (86.9%) 15:35:09 INFO - TinderboxPrint: CPU user
1,182.1 (12.5%) 15:35:09 INFO - TinderboxPrint: Swap in / out
0 / 0 15:35:09 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 76070912; Read time: 0; Write time: 83628 15:35:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:35:09 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 573440; Write bytes: 280797184; Read time: 44; Write time: 191328 15:35:10 INFO - Running post-run listener: _upload_blobber_files 15:35:10 INFO - Blob upload gear active. 15:35:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:35:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:11 INFO - (blobuploader) - INFO - Done attempting. 15:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:12 INFO - (blobuploader) - INFO - Done attempting. 15:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:13 INFO - (blobuploader) - INFO - Done attempting. 15:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:21 INFO - (blobuploader) - INFO - Done attempting. 15:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:21 INFO - Return code: 0 15:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f2f03d10270c785bdfbd08be9100d5904650df2acc75c71b059654589e77335e6279b38f9942a8c31d08a3db50145e305722f43372df871557048ce33140484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9f26f404f1d37177eee4f395002a9492e4c2c5eb928c9414b51e6bd00a9f4db4b242f7393ef4bab97f3987ed65344786d2230629240b9f4e0565ea03873eb9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c85c489c585b4288249a973ff3dca88e176404d9dad99971cd3b28f6cfe18a9c72872e1683dec87e11a4a55f27454807fe2ebcb816a1bfad0a5d26f30cecad5c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6b8147a6dd7569f6a276560970e46b6724152c0c1914ff9e5af6aec38dd4f0094970c47766306ae1cb2d367c96ddbf297b28275e4b54c42cbbffa64d98e130a0"} 15:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:21 INFO - Contents: 15:35:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f2f03d10270c785bdfbd08be9100d5904650df2acc75c71b059654589e77335e6279b38f9942a8c31d08a3db50145e305722f43372df871557048ce33140484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9f26f404f1d37177eee4f395002a9492e4c2c5eb928c9414b51e6bd00a9f4db4b242f7393ef4bab97f3987ed65344786d2230629240b9f4e0565ea03873eb9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c85c489c585b4288249a973ff3dca88e176404d9dad99971cd3b28f6cfe18a9c72872e1683dec87e11a4a55f27454807fe2ebcb816a1bfad0a5d26f30cecad5c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6b8147a6dd7569f6a276560970e46b6724152c0c1914ff9e5af6aec38dd4f0094970c47766306ae1cb2d367c96ddbf297b28275e4b54c42cbbffa64d98e130a0"} 15:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:21 INFO - Copying logs to upload dir... 15:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.578894 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-18 15:35:21.376635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 15:35:21.383744) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f2f03d10270c785bdfbd08be9100d5904650df2acc75c71b059654589e77335e6279b38f9942a8c31d08a3db50145e305722f43372df871557048ce33140484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9f26f404f1d37177eee4f395002a9492e4c2c5eb928c9414b51e6bd00a9f4db4b242f7393ef4bab97f3987ed65344786d2230629240b9f4e0565ea03873eb9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c85c489c585b4288249a973ff3dca88e176404d9dad99971cd3b28f6cfe18a9c72872e1683dec87e11a4a55f27454807fe2ebcb816a1bfad0a5d26f30cecad5c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6b8147a6dd7569f6a276560970e46b6724152c0c1914ff9e5af6aec38dd4f0094970c47766306ae1cb2d367c96ddbf297b28275e4b54c42cbbffa64d98e130a0"} build_url:https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/U1IqJAEYRfKg0fMDakqifw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f2f03d10270c785bdfbd08be9100d5904650df2acc75c71b059654589e77335e6279b38f9942a8c31d08a3db50145e305722f43372df871557048ce33140484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9f26f404f1d37177eee4f395002a9492e4c2c5eb928c9414b51e6bd00a9f4db4b242f7393ef4bab97f3987ed65344786d2230629240b9f4e0565ea03873eb9d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c85c489c585b4288249a973ff3dca88e176404d9dad99971cd3b28f6cfe18a9c72872e1683dec87e11a4a55f27454807fe2ebcb816a1bfad0a5d26f30cecad5c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6b8147a6dd7569f6a276560970e46b6724152c0c1914ff9e5af6aec38dd4f0094970c47766306ae1cb2d367c96ddbf297b28275e4b54c42cbbffa64d98e130a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 15:35:21.415083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:35:21.415432) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505769199.763917-178212009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:35:21.497161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 15:35:21.500500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 15:35:21.500839) ========= ========= Total master_lag: 0.30 =========