builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1505957903.27 results: success (0) revision: a6fb3b978941f76b727eafee21ea3d440299648d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.272977) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.273514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.273799) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.291138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.291399) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 18:38:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225K=0.05s 2017-09-20 18:38:23 (225 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.193958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.500828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.501216) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.552880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:23.553576) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6fb3b978941f76b727eafee21ea3d440299648d --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 a6fb3b978941f76b727eafee21ea3d440299648d --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=e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 18:38:23,621 truncating revision to first 12 chars 2017-09-20 18:38:23,621 Setting DEBUG logging. 2017-09-20 18:38:23,621 attempt 1/10 2017-09-20 18:38:23,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a6fb3b978941?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 18:38:24,131 unpacking tar archive at: mozilla-beta-a6fb3b978941/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:24.486144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:24.486463) ========= script_repo_revision: a6fb3b978941f76b727eafee21ea3d440299648d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:24.486906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:24.487171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 18:38:24.506066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-20 18:38:24.506369) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:38:24 INFO - MultiFileLogger online at 20170920 18:38:24 in /builds/slave/test 18:38:24 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 18:38:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:38:24 INFO - {'append_to_log': False, 18:38:24 INFO - 'base_work_dir': '/builds/slave/test', 18:38:24 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:38:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:38:24 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:38:24 INFO - 'buildbot_json_path': 'buildprops.json', 18:38:24 INFO - 'code_coverage': False, 18:38:24 INFO - 'config_files': ('talos/linux_config.py',), 18:38:24 INFO - 'default_actions': ('clobber', 18:38:24 INFO - 'read-buildbot-config', 18:38:24 INFO - 'download-and-extract', 18:38:24 INFO - 'populate-webroot', 18:38:24 INFO - 'create-virtualenv', 18:38:24 INFO - 'install', 18:38:24 INFO - 'setup-mitmproxy', 18:38:24 INFO - 'run-tests'), 18:38:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:38:24 INFO - 'disable_ccov_upload': False, 18:38:24 INFO - 'download_minidump_stackwalk': True, 18:38:24 INFO - 'download_symbols': 'ondemand', 18:38:24 INFO - 'enable_stylo': False, 18:38:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:38:24 INFO - 'tooltool.py': '/tools/tooltool.py', 18:38:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:38:24 INFO - '/tools/misc-python/virtualenv.py')}, 18:38:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:38:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:38:24 INFO - 'gecko_profile': False, 18:38:24 INFO - 'gecko_profile_interval': 0, 18:38:24 INFO - 'installer_path': 'installer.exe', 18:38:24 INFO - 'log_level': 'info', 18:38:24 INFO - 'log_name': 'talos', 18:38:24 INFO - 'log_to_console': True, 18:38:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:38:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:38:24 INFO - 'opt_config_files': (), 18:38:24 INFO - 'pip_index': False, 18:38:24 INFO - 'suite': 'dromaeojs-e10s', 18:38:24 INFO - 'system_bits': '32', 18:38:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:38:24 INFO - 'title': 'talos-linux64-ix-006', 18:38:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:38:24 INFO - 'use_talos_json': True, 18:38:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:38:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:38:24 INFO - 'work_dir': 'build'} 18:38:24 INFO - [mozharness: 2017-09-21 01:38:24.681655Z] Running clobber step. 18:38:24 INFO - Running pre-action listener: _resource_record_pre_action 18:38:24 INFO - Running main action method: clobber 18:38:24 INFO - rmtree: /builds/slave/test/build 18:38:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:38:26 INFO - Running post-action listener: _resource_record_post_action 18:38:26 INFO - [mozharness: 2017-09-21 01:38:26.210818Z] Finished clobber step (success) 18:38:26 INFO - [mozharness: 2017-09-21 01:38:26.210918Z] Running read-buildbot-config step. 18:38:26 INFO - Running pre-action listener: _resource_record_pre_action 18:38:26 INFO - Running main action method: read_buildbot_config 18:38:26 INFO - Using buildbot properties: 18:38:26 INFO - { 18:38:26 INFO - "project": "", 18:38:26 INFO - "product": "firefox", 18:38:26 INFO - "who": "ryanvm@gmail.com", 18:38:26 INFO - "installer_path": "public/build/target.tar.bz2", 18:38:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:38:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:38:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:38:26 INFO - "stage_platform": "linux64", 18:38:26 INFO - "basedir": "/builds/slave/test", 18:38:26 INFO - "buildnumber": 110, 18:38:26 INFO - "platform": "ubuntu64_hw", 18:38:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:38:26 INFO - "slavebuilddir": "test", 18:38:26 INFO - "taskId": "HzByF-JvT6GzRUcoCEBccA", 18:38:26 INFO - "branch": "mozilla-beta", 18:38:26 INFO - "script_repo_revision": "production", 18:38:26 INFO - "revision": "a6fb3b978941f76b727eafee21ea3d440299648d", 18:38:26 INFO - "slavename": "talos-linux64-ix-006", 18:38:26 INFO - "repo_path": "releases/mozilla-beta" 18:38:26 INFO - } 18:38:26 INFO - Finding installer, test and symbols from parent task. 18:38:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HzByF-JvT6GzRUcoCEBccA'}, attempt #1 18:38:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HzByF-JvT6GzRUcoCEBccA'}, attempt #1 18:38:27 INFO - Task dependencies: bY8Gk3bnSgOe36AYStGP1g 18:38:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g'}, attempt #1 18:38:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2 18:38:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.test_packages.json 18:38:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.crashreporter-symbols.zip 18:38:27 INFO - Running post-action listener: _resource_record_post_action 18:38:27 INFO - [mozharness: 2017-09-21 01:38:27.590184Z] Finished read-buildbot-config step (success) 18:38:27 INFO - [mozharness: 2017-09-21 01:38:27.590406Z] Running download-and-extract step. 18:38:27 INFO - Running pre-action listener: _resource_record_pre_action 18:38:27 INFO - Running main action method: download_and_extract 18:38:27 INFO - mkdir: /builds/slave/test/build/tests 18:38:27 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')]} 18:38:27 INFO - trying https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.test_packages.json 18:38:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:38:28 INFO - Downloaded 989 bytes. 18:38:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:38:28 INFO - Using the following test package requirements: 18:38:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:38:28 INFO - u'common': [u'target.common.tests.zip'], 18:38:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:38:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:38:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:38:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:38:28 INFO - u'mozbase': [u'target.common.tests.zip'], 18:38:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:38:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:38:28 INFO - u'web-platform': [u'target.common.tests.zip', 18:38:28 INFO - u'target.web-platform.tests.tar.gz'], 18:38:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:38:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:38:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.common.tests.zip 18:38:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:38:28 INFO - Fetch https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.common.tests.zip into memory 18:38:29 INFO - Content-Length response header: 72855306 18:38:29 INFO - Bytes received: 72855306 18:38:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.talos.tests.zip 18:38:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:38:40 INFO - Fetch https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.talos.tests.zip into memory 18:38:41 INFO - Content-Length response header: 14496472 18:38:41 INFO - Bytes received: 14496472 18:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:41 INFO - trying https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2 18:38:41 INFO - Downloading https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:38:42 INFO - Downloaded 54192481 bytes. 18:38:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2 18:38:42 INFO - mkdir: /builds/slave/test/properties 18:38:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:42 INFO - Contents: 18:38:42 INFO - build_url:https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2 18:38:42 INFO - Running post-action listener: _resource_record_post_action 18:38:42 INFO - Running post-action listener: set_extra_try_arguments 18:38:42 INFO - [mozharness: 2017-09-21 01:38:42.768913Z] Finished download-and-extract step (success) 18:38:42 INFO - [mozharness: 2017-09-21 01:38:42.769013Z] Running populate-webroot step. 18:38:42 INFO - Running pre-action listener: _resource_record_pre_action 18:38:42 INFO - Running main action method: populate_webroot 18:38:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:38:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:38:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:38:42 INFO - 'tests': ['damp', 'tps']}, 18:38:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:38:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:38:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:38:42 INFO - 'other-e10s': {'tests': ['a11yr', 18:38:42 INFO - 'ts_paint', 18:38:42 INFO - 'tpaint', 18:38:42 INFO - 'sessionrestore', 18:38:42 INFO - 'sessionrestore_many_windows', 18:38:42 INFO - 'sessionrestore_no_auto_restore', 18:38:42 INFO - 'tabpaint']}, 18:38:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:38:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:38:42 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:38:42 INFO - 'talos_options': ['--mitmproxy', 18:38:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:38:42 INFO - '--firstNonBlankPaint'], 18:38:42 INFO - 'tests': ['quantum_pageload_google', 18:38:42 INFO - 'quantum_pageload_youtube', 18:38:42 INFO - 'quantum_pageload_amazon', 18:38:42 INFO - 'quantum_pageload_facebook']}, 18:38:42 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:38:42 INFO - 'talos_options': ['--stylo', 18:38:42 INFO - '--mitmproxy', 18:38:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:38:42 INFO - '--firstNonBlankPaint'], 18:38:42 INFO - 'tests': ['quantum_pageload_google', 18:38:42 INFO - 'quantum_pageload_youtube', 18:38:42 INFO - 'quantum_pageload_amazon', 18:38:42 INFO - 'quantum_pageload_facebook']}, 18:38:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:38:42 INFO - 'tsvgr_opacity', 18:38:42 INFO - 'tart', 18:38:42 INFO - 'tscrollx', 18:38:42 INFO - 'cart', 18:38:42 INFO - 'tsvg_static']}, 18:38:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:38:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:38:42 INFO - 'talos_options': ['--stylo', 18:38:42 INFO - '--stylo-threads=1', 18:38:42 INFO - '--mitmproxy', 18:38:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:38:42 INFO - '--firstNonBlankPaint'], 18:38:42 INFO - 'tests': ['tp6_google', 18:38:42 INFO - 'tp6_youtube', 18:38:42 INFO - 'tp6_amazon', 18:38:42 INFO - 'tp6_facebook']}, 18:38:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:38:42 INFO - 'talos_options': ['--xperf_path', 18:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:42 INFO - 'tests': ['tp5n']}}} 18:38:42 INFO - Running post-action listener: _resource_record_post_action 18:38:42 INFO - [mozharness: 2017-09-21 01:38:42.782809Z] Finished populate-webroot step (success) 18:38:42 INFO - [mozharness: 2017-09-21 01:38:42.782988Z] Running create-virtualenv step. 18:38:42 INFO - Running pre-action listener: _resource_record_pre_action 18:38:42 INFO - Running main action method: create_virtualenv 18:38:42 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:42 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 18:38:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:38:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:38:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:43 INFO - Using real prefix '/usr' 18:38:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:43 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:45 INFO - Installing pip.................done. 18:38:45 INFO - Return code: 0 18:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:38:45 INFO - Reading from file tmpfile_stdout 18:38:45 INFO - Output received: 18:38:45 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) 18:38:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38: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')]} 18:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38: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')]} 18:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:38:45 INFO - Using env: {'DISPLAY': ':0', 18:38:45 INFO - 'HOME': '/home/cltbld', 18:38:45 INFO - 'LANG': 'en_US.UTF-8', 18:38:45 INFO - 'LANGUAGE': 'en_US:en', 18:38:45 INFO - 'LOGNAME': 'cltbld', 18:38:45 INFO - 'MAIL': '/var/mail/cltbld', 18:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:45 INFO - 'MOZ_NO_REMOTE': '1', 18:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:45 INFO - 'NO_EM_RESTART': '1', 18:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:45 INFO - 'PWD': '/builds/slave/test', 18:38:45 INFO - 'SHELL': '/bin/bash', 18:38:45 INFO - 'SHLVL': '1', 18:38:45 INFO - 'TERM': 'linux', 18:38:45 INFO - 'TMOUT': '86400', 18:38:45 INFO - 'USER': 'cltbld', 18:38:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:45 INFO - '_': '/tools/buildbot/bin/python'} 18:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:45 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 18:38:45 INFO - Cleaning up... 18:38:45 INFO - Return code: 0 18:38:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:38: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')]} 18:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38: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')]} 18:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:38:45 INFO - Using env: {'DISPLAY': ':0', 18:38:45 INFO - 'HOME': '/home/cltbld', 18:38:45 INFO - 'LANG': 'en_US.UTF-8', 18:38:45 INFO - 'LANGUAGE': 'en_US:en', 18:38:45 INFO - 'LOGNAME': 'cltbld', 18:38:45 INFO - 'MAIL': '/var/mail/cltbld', 18:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:45 INFO - 'MOZ_NO_REMOTE': '1', 18:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:45 INFO - 'NO_EM_RESTART': '1', 18:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:45 INFO - 'PWD': '/builds/slave/test', 18:38:45 INFO - 'SHELL': '/bin/bash', 18:38:45 INFO - 'SHLVL': '1', 18:38:45 INFO - 'TERM': 'linux', 18:38:45 INFO - 'TMOUT': '86400', 18:38:45 INFO - 'USER': 'cltbld', 18:38:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:45 INFO - '_': '/tools/buildbot/bin/python'} 18:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:46 INFO - Downloading/unpacking psutil>=3.1.1 18:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:47 INFO - Installing collected packages: psutil 18:38:47 INFO - Running setup.py install for psutil 18:38:47 INFO - building 'psutil._psutil_linux' extension 18:38:47 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 18:38:47 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 18:38:47 INFO - building 'psutil._psutil_posix' extension 18:38:47 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 18:38:47 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 18:38:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:47 INFO - Successfully installed psutil 18:38:47 INFO - Cleaning up... 18:38:48 INFO - Return code: 0 18:38:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:38:48 INFO - Using env: {'DISPLAY': ':0', 18:38:48 INFO - 'HOME': '/home/cltbld', 18:38:48 INFO - 'LANG': 'en_US.UTF-8', 18:38:48 INFO - 'LANGUAGE': 'en_US:en', 18:38:48 INFO - 'LOGNAME': 'cltbld', 18:38:48 INFO - 'MAIL': '/var/mail/cltbld', 18:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:48 INFO - 'MOZ_NO_REMOTE': '1', 18:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:48 INFO - 'NO_EM_RESTART': '1', 18:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:48 INFO - 'PWD': '/builds/slave/test', 18:38:48 INFO - 'SHELL': '/bin/bash', 18:38:48 INFO - 'SHLVL': '1', 18:38:48 INFO - 'TERM': 'linux', 18:38:48 INFO - 'TMOUT': '86400', 18:38:48 INFO - 'USER': 'cltbld', 18:38:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:48 INFO - '_': '/tools/buildbot/bin/python'} 18:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:38:50 INFO - Installing collected packages: mozsystemmonitor 18:38:50 INFO - Running setup.py install for mozsystemmonitor 18:38:51 INFO - Successfully installed mozsystemmonitor 18:38:51 INFO - Cleaning up... 18:38:52 INFO - Return code: 0 18:38:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:52 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:52 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 18:38:52 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 18:38:52 INFO - Using env: {'DISPLAY': ':0', 18:38:52 INFO - 'HOME': '/home/cltbld', 18:38:52 INFO - 'LANG': 'en_US.UTF-8', 18:38:52 INFO - 'LANGUAGE': 'en_US:en', 18:38:52 INFO - 'LOGNAME': 'cltbld', 18:38:52 INFO - 'MAIL': '/var/mail/cltbld', 18:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:52 INFO - 'MOZ_NO_REMOTE': '1', 18:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:52 INFO - 'NO_EM_RESTART': '1', 18:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:52 INFO - 'PWD': '/builds/slave/test', 18:38:52 INFO - 'SHELL': '/bin/bash', 18:38:52 INFO - 'SHLVL': '1', 18:38:52 INFO - 'TERM': 'linux', 18:38:52 INFO - 'TMOUT': '86400', 18:38:52 INFO - 'USER': 'cltbld', 18:38:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:52 INFO - '_': '/tools/buildbot/bin/python'} 18:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:52 INFO - Downloading/unpacking jsonschema==2.5.1 18:38:52 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 18:38:52 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 18:38:52 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 18:38:52 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 18:38:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:38:53 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 18:38:53 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 18:38:53 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 18:38:53 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 18:38:53 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:53 INFO - warning: no files found matching '*.txt' 18:38:53 INFO - no previously-included directories found matching 'build' 18:38:53 INFO - no previously-included directories found matching 'dist' 18:38:53 INFO - no previously-included directories found matching '.git*' 18:38:53 INFO - Installing collected packages: jsonschema, functools32 18:38:53 INFO - Running setup.py install for functools32 18:38:53 INFO - warning: no files found matching '*.txt' 18:38:53 INFO - no previously-included directories found matching 'build' 18:38:53 INFO - no previously-included directories found matching 'dist' 18:38:53 INFO - no previously-included directories found matching '.git*' 18:38:53 INFO - Successfully installed jsonschema functools32 18:38:53 INFO - Cleaning up... 18:38:53 INFO - Return code: 0 18:38:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:53 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:53 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 18:38:53 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 18:38:53 INFO - Using env: {'DISPLAY': ':0', 18:38:53 INFO - 'HOME': '/home/cltbld', 18:38:53 INFO - 'LANG': 'en_US.UTF-8', 18:38:53 INFO - 'LANGUAGE': 'en_US:en', 18:38:53 INFO - 'LOGNAME': 'cltbld', 18:38:53 INFO - 'MAIL': '/var/mail/cltbld', 18:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:53 INFO - 'MOZ_NO_REMOTE': '1', 18:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:53 INFO - 'NO_EM_RESTART': '1', 18:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:53 INFO - 'PWD': '/builds/slave/test', 18:38:53 INFO - 'SHELL': '/bin/bash', 18:38:53 INFO - 'SHLVL': '1', 18:38:53 INFO - 'TERM': 'linux', 18:38:53 INFO - 'TMOUT': '86400', 18:38:53 INFO - 'USER': 'cltbld', 18:38:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:53 INFO - '_': '/tools/buildbot/bin/python'} 18:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:38:54 INFO - Cleaning up... 18:38:54 INFO - Return code: 0 18:38:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:54 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:54 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 18:38:54 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 18:38:54 INFO - Using env: {'DISPLAY': ':0', 18:38:54 INFO - 'HOME': '/home/cltbld', 18:38:54 INFO - 'LANG': 'en_US.UTF-8', 18:38:54 INFO - 'LANGUAGE': 'en_US:en', 18:38:54 INFO - 'LOGNAME': 'cltbld', 18:38:54 INFO - 'MAIL': '/var/mail/cltbld', 18:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:54 INFO - 'MOZ_NO_REMOTE': '1', 18:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:54 INFO - 'NO_EM_RESTART': '1', 18:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:54 INFO - 'PWD': '/builds/slave/test', 18:38:54 INFO - 'SHELL': '/bin/bash', 18:38:54 INFO - 'SHLVL': '1', 18:38:54 INFO - 'TERM': 'linux', 18:38:54 INFO - 'TMOUT': '86400', 18:38:54 INFO - 'USER': 'cltbld', 18:38:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:54 INFO - '_': '/tools/buildbot/bin/python'} 18:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:54 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 18:38:54 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 18:38:54 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 18:38:54 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 18:38:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:55 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 18:38:55 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 18:38:55 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 18:38:55 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 18:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:55 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 18:38:55 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 18:38:55 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 18:38:55 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 18:38:55 INFO - Downloading docopt-0.6.1.tar.gz 18:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:56 INFO - Running setup.py install for blobuploader 18:38:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:56 INFO - Running setup.py install for requests 18:38:56 INFO - Running setup.py install for docopt 18:38:56 INFO - Successfully installed blobuploader requests docopt 18:38:56 INFO - Cleaning up... 18:38:56 INFO - Return code: 0 18:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:56 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:56 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 18:38:56 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 18:38:56 INFO - Using env: {'DISPLAY': ':0', 18:38:56 INFO - 'HOME': '/home/cltbld', 18:38:56 INFO - 'LANG': 'en_US.UTF-8', 18:38:56 INFO - 'LANGUAGE': 'en_US:en', 18:38:56 INFO - 'LOGNAME': 'cltbld', 18:38:56 INFO - 'MAIL': '/var/mail/cltbld', 18:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:56 INFO - 'MOZ_NO_REMOTE': '1', 18:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:56 INFO - 'NO_EM_RESTART': '1', 18:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:56 INFO - 'PWD': '/builds/slave/test', 18:38:56 INFO - 'SHELL': '/bin/bash', 18:38:56 INFO - 'SHLVL': '1', 18:38:56 INFO - 'TERM': 'linux', 18:38:56 INFO - 'TMOUT': '86400', 18:38:56 INFO - 'USER': 'cltbld', 18:38:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:56 INFO - '_': '/tools/buildbot/bin/python'} 18:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:56 INFO - Running setup.py (path:/tmp/pip-qCeafc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:56 INFO - Running setup.py (path:/tmp/pip-QD9TQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:57 INFO - Running setup.py (path:/tmp/pip-VPzt3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:57 INFO - Running setup.py (path:/tmp/pip-0Y4lc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:57 INFO - Running setup.py (path:/tmp/pip-MyVavm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:57 INFO - Running setup.py (path:/tmp/pip-3EGqIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:57 INFO - Running setup.py (path:/tmp/pip-CX7kn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:57 INFO - Running setup.py (path:/tmp/pip-Gk8vuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:57 INFO - Running setup.py (path:/tmp/pip-gWKjac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:57 INFO - Running setup.py (path:/tmp/pip-sKM3_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:57 INFO - Running setup.py (path:/tmp/pip-fQtodY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:57 INFO - Running setup.py (path:/tmp/pip-PuNheZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:57 INFO - Running setup.py (path:/tmp/pip-2_NAAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:57 INFO - Running setup.py (path:/tmp/pip-3iMoa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:57 INFO - Running setup.py (path:/tmp/pip-qEEFSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:57 INFO - Running setup.py (path:/tmp/pip-Ipkp9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:58 INFO - Running setup.py (path:/tmp/pip-PgMWKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:58 INFO - Running setup.py install for manifestparser 18:38:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Running setup.py install for mozcrash 18:38:58 INFO - Running setup.py install for mozdebug 18:38:58 INFO - Running setup.py install for mozdevice 18:38:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Running setup.py install for mozfile 18:38:58 INFO - Running setup.py install for mozhttpd 18:38:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Running setup.py install for mozinfo 18:38:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Running setup.py install for mozInstall 18:38:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:58 INFO - Running setup.py install for mozleak 18:38:58 INFO - Running setup.py install for mozlog 18:38:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Running setup.py install for moznetwork 18:38:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Running setup.py install for mozprocess 18:38:59 INFO - Running setup.py install for mozprofile 18:38:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Running setup.py install for mozrunner 18:38:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Running setup.py install for mozscreenshot 18:38:59 INFO - Running setup.py install for moztest 18:38:59 INFO - Running setup.py install for mozversion 18:38:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:59 INFO - Cleaning up... 18:38:59 INFO - Return code: 0 18:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:59 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:38:59 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 18:38:59 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 18:38:59 INFO - Using env: {'DISPLAY': ':0', 18:38:59 INFO - 'HOME': '/home/cltbld', 18:38:59 INFO - 'LANG': 'en_US.UTF-8', 18:38:59 INFO - 'LANGUAGE': 'en_US:en', 18:38:59 INFO - 'LOGNAME': 'cltbld', 18:38:59 INFO - 'MAIL': '/var/mail/cltbld', 18:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:59 INFO - 'MOZ_NO_REMOTE': '1', 18:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:59 INFO - 'NO_EM_RESTART': '1', 18:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:59 INFO - 'PWD': '/builds/slave/test', 18:38:59 INFO - 'SHELL': '/bin/bash', 18:38:59 INFO - 'SHLVL': '1', 18:38:59 INFO - 'TERM': 'linux', 18:38:59 INFO - 'TMOUT': '86400', 18:38:59 INFO - 'USER': 'cltbld', 18:38:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:59 INFO - '_': '/tools/buildbot/bin/python'} 18:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:39:00 INFO - Running setup.py (path:/tmp/pip-aR8Qys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:39:00 INFO - Running setup.py (path:/tmp/pip-mdPlQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:39:00 INFO - Running setup.py (path:/tmp/pip-H6aSC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:39:00 INFO - Running setup.py (path:/tmp/pip-J_RFHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:39:00 INFO - Running setup.py (path:/tmp/pip-iv_FS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:39:00 INFO - Running setup.py (path:/tmp/pip-xyI6Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:39:00 INFO - Running setup.py (path:/tmp/pip-RCU2Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:39:00 INFO - Running setup.py (path:/tmp/pip-WATtge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:39:00 INFO - Running setup.py (path:/tmp/pip-GNuAQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:39:00 INFO - Running setup.py (path:/tmp/pip-wjzPZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:39:00 INFO - Running setup.py (path:/tmp/pip-FJ6YJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:39:00 INFO - Running setup.py (path:/tmp/pip-_7DD9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:39:00 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)) 18:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:39:00 INFO - Running setup.py (path:/tmp/pip-EezIpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:39:01 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)) 18:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:39:01 INFO - Running setup.py (path:/tmp/pip-3CveE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:39:01 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)) 18:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:39:01 INFO - Running setup.py (path:/tmp/pip-CVtuc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:39:01 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)) 18:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:39:01 INFO - Running setup.py (path:/tmp/pip-dErjDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:39:01 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)) 18:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:39:01 INFO - Running setup.py (path:/tmp/pip-Mv94mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:39:01 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)) 18:39:01 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)) 18:39:01 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)) 18:39:01 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)) 18:39:01 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)) 18:39:01 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)) 18:39:01 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)) 18:39:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:02 INFO - Downloading blessings-1.6.tar.gz 18:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:39:02 INFO - Installing collected packages: blessings 18:39:02 INFO - Running setup.py install for blessings 18:39:02 INFO - Successfully installed blessings 18:39:02 INFO - Cleaning up... 18:39:02 INFO - Return code: 0 18:39:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:39:02 INFO - Reading from file tmpfile_stdout 18:39:02 INFO - Current package versions: 18:39:02 INFO - argparse == 1.2.1 18:39:02 INFO - blessings == 1.6 18:39:02 INFO - blobuploader == 1.2.4 18:39:02 INFO - docopt == 0.6.1 18:39:02 INFO - functools32 == 3.2.3-2 18:39:02 INFO - jsonschema == 2.5.1 18:39:02 INFO - manifestparser == 1.1 18:39:02 INFO - mozInstall == 1.13 18:39:02 INFO - mozcrash == 1.0 18:39:02 INFO - mozdebug == 0.1 18:39:02 INFO - mozdevice == 0.51 18:39:02 INFO - mozfile == 1.2 18:39:02 INFO - mozhttpd == 0.7 18:39:02 INFO - mozinfo == 0.10 18:39:02 INFO - mozleak == 0.1 18:39:02 INFO - mozlog == 3.5 18:39:02 INFO - moznetwork == 0.27 18:39:02 INFO - mozprocess == 0.25 18:39:02 INFO - mozprofile == 0.28 18:39:02 INFO - mozrunner == 6.13 18:39:02 INFO - mozscreenshot == 0.1 18:39:02 INFO - mozsystemmonitor == 0.3 18:39:02 INFO - moztest == 0.8 18:39:02 INFO - mozversion == 1.4 18:39:02 INFO - psutil == 3.1.1 18:39:02 INFO - requests == 1.2.3 18:39:02 INFO - wsgiref == 0.1.2 18:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:02 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:39:02 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 18:39:02 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 18:39:02 INFO - Using env: {'DISPLAY': ':0', 18:39:02 INFO - 'HOME': '/home/cltbld', 18:39:02 INFO - 'LANG': 'en_US.UTF-8', 18:39:02 INFO - 'LANGUAGE': 'en_US:en', 18:39:02 INFO - 'LOGNAME': 'cltbld', 18:39:02 INFO - 'MAIL': '/var/mail/cltbld', 18:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:02 INFO - 'MOZ_NO_REMOTE': '1', 18:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:02 INFO - 'NO_EM_RESTART': '1', 18:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:02 INFO - 'PWD': '/builds/slave/test', 18:39:02 INFO - 'SHELL': '/bin/bash', 18:39:02 INFO - 'SHLVL': '1', 18:39:02 INFO - 'TERM': 'linux', 18:39:02 INFO - 'TMOUT': '86400', 18:39:02 INFO - 'USER': 'cltbld', 18:39:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:02 INFO - '_': '/tools/buildbot/bin/python'} 18:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 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)) 18:39:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:39:04 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)) 18:39:04 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)) 18:39:04 INFO - Installing collected packages: simplejson 18:39:04 INFO - Running setup.py install for simplejson 18:39:04 INFO - building 'simplejson._speedups' extension 18:39:04 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 18:39:05 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 18:39:05 INFO - Successfully installed simplejson 18:39:05 INFO - Cleaning up... 18:39:05 INFO - Return code: 0 18:39:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188feb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', '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 18:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:39:05 INFO - Using env: {'DISPLAY': ':0', 18:39:05 INFO - 'HOME': '/home/cltbld', 18:39:05 INFO - 'LANG': 'en_US.UTF-8', 18:39:05 INFO - 'LANGUAGE': 'en_US:en', 18:39:05 INFO - 'LOGNAME': 'cltbld', 18:39:05 INFO - 'MAIL': '/var/mail/cltbld', 18:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:05 INFO - 'MOZ_NO_REMOTE': '1', 18:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:05 INFO - 'NO_EM_RESTART': '1', 18:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:05 INFO - 'PWD': '/builds/slave/test', 18:39:05 INFO - 'SHELL': '/bin/bash', 18:39:05 INFO - 'SHLVL': '1', 18:39:05 INFO - 'TERM': 'linux', 18:39:05 INFO - 'TMOUT': '86400', 18:39:05 INFO - 'USER': 'cltbld', 18:39:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:05 INFO - '_': '/tools/buildbot/bin/python'} 18:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:39:05 INFO - Cleaning up... 18:39:05 INFO - Return code: 0 18:39:05 INFO - Running post-action listener: _resource_record_post_action 18:39:05 INFO - Running post-action listener: _start_resource_monitoring 18:39:05 INFO - Starting resource monitoring. 18:39:05 INFO - [mozharness: 2017-09-21 01:39:05.676246Z] Finished create-virtualenv step (success) 18:39:05 INFO - [mozharness: 2017-09-21 01:39:05.676708Z] Running install step. 18:39:05 INFO - Running pre-action listener: _resource_record_pre_action 18:39:05 INFO - Running main action method: install 18:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:39:05 INFO - Reading from file tmpfile_stdout 18:39:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:39:06 INFO - Reading from file tmpfile_stdout 18:39:06 INFO - Output received: 18:39:06 INFO - Usage: mozinstall [options] installer 18:39:06 INFO - Options: 18:39:06 INFO - -h, --help show this help message and exit 18:39:06 INFO - -d DEST, --destination=DEST 18:39:06 INFO - Directory to install application into. [default: 18:39:06 INFO - "/builds/slave/test"] 18:39:06 INFO - --app=APP Application being installed. [default: firefox] 18:39:06 INFO - mkdir: /builds/slave/test/build/application 18:39:06 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'] 18:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:39:20 INFO - Reading from file tmpfile_stdout 18:39:20 INFO - Output received: 18:39:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:39:20 INFO - Running post-action listener: _resource_record_post_action 18:39:20 INFO - [mozharness: 2017-09-21 01:39:20.843388Z] Finished install step (success) 18:39:20 INFO - [mozharness: 2017-09-21 01:39:20.843640Z] Running setup-mitmproxy step. 18:39:20 INFO - Running pre-action listener: _resource_record_pre_action 18:39:20 INFO - Running main action method: setup_mitmproxy 18:39:20 INFO - Skipping: mitmproxy is not required 18:39:20 INFO - Running post-action listener: _resource_record_post_action 18:39:20 INFO - [mozharness: 2017-09-21 01:39:20.844795Z] Finished setup-mitmproxy step (success) 18:39:20 INFO - [mozharness: 2017-09-21 01:39:20.845019Z] Running run-tests step. 18:39:20 INFO - Running pre-action listener: _resource_record_pre_action 18:39:20 INFO - Running pre-action listener: _set_gcov_prefix 18:39:20 INFO - Running main action method: run_tests 18:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:39:20 INFO - Python 2.7.3 18:39:20 INFO - Return code: 0 18:39:20 INFO - grabbing minidump binary from tooltool 18:39:20 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')]} 18:39:20 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 0x188d050>, '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 0x188df50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e3e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:39:20 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 18:39:20 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 18:39:20 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 18:39:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:39:20 INFO - Return code: 0 18:39:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:39:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:39:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:39:20 INFO - ENV: RUST_BACKTRACE is now 1 18:39:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:39:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:39:20 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/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 18:39:20 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/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 18:39:20 INFO - Using env: {'DISPLAY': ':0', 18:39:20 INFO - 'HOME': '/home/cltbld', 18:39:20 INFO - 'LANG': 'en_US.UTF-8', 18:39:20 INFO - 'LANGUAGE': 'en_US:en', 18:39:20 INFO - 'LOGNAME': 'cltbld', 18:39:20 INFO - 'MAIL': '/var/mail/cltbld', 18:39:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:39:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:20 INFO - 'MOZ_NO_REMOTE': '1', 18:39:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:20 INFO - 'NO_EM_RESTART': '1', 18:39:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:20 INFO - 'PWD': '/builds/slave/test', 18:39:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:39:20 INFO - 'RUST_BACKTRACE': '1', 18:39:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:39:20 INFO - 'SHELL': '/bin/bash', 18:39:20 INFO - 'SHLVL': '1', 18:39:20 INFO - 'TERM': 'linux', 18:39:20 INFO - 'TMOUT': '86400', 18:39:20 INFO - 'USER': 'cltbld', 18:39:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521', 18:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:20 INFO - '_': '/tools/buildbot/bin/python'} 18:39:20 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/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 18:39:21 INFO - mozversion application_buildid: 20170921002159 18:39:21 INFO - mozversion application_changeset: a6fb3b978941f76b727eafee21ea3d440299648d 18:39:21 INFO - mozversion application_display_name: Firefox 18:39:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:39:21 INFO - mozversion application_name: Firefox 18:39:21 INFO - mozversion application_remotingname: firefox 18:39:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:39:21 INFO - mozversion application_vendor: Mozilla 18:39:21 INFO - mozversion application_version: 56.0 18:39:21 INFO - mozversion platform_buildid: 20170921002159 18:39:21 INFO - mozversion platform_changeset: a6fb3b978941f76b727eafee21ea3d440299648d 18:39:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:39:21 INFO - mozversion platform_version: 56.0 18:39:21 INFO - using testdate: 1505957961 18:39:21 INFO - actual date: 1505957961 18:39:21 INFO - starting webserver on 'localhost:35794' 18:39:21 INFO - SUITE-START | Running 2 tests 18:39:21 INFO - TEST-START | dromaeo_css 18:39:21 INFO - Initialising browser for dromaeo_css test... 18:39:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35794/getInfo.html -profile /tmp/tmpDHAdn8/profile 18:39:21 INFO - TEST-INFO | started process 24513 (/builds/slave/test/build/application/firefox/firefox http://localhost:35794/getInfo.html) 18:39:26 INFO - TEST-INFO | 24513: exit 0 18:39:27 INFO - Browser initialized. 18:39:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:39:27 INFO - TEST-INFO | started process 24678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDHAdn8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:38 INFO - PID 24678 | RSS: Main: 151044096 18:39:38 INFO - PID 24678 | 18:42:35 INFO - PID 24678 | Cycle 1(1): loaded http://localhost:35794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35794/tests/dromaeo/cssquery-ext.html) 18:42:37 INFO - PID 24678 | RSS: Main: 161218560 18:42:37 INFO - PID 24678 | 18:45:38 INFO - PID 24678 | Cycle 1(1): loaded http://localhost:35794/tests/dromaeo/cssquery-ext.html (next: http://localhost:35794/tests/dromaeo/cssquery-jquery.html) 18:45:39 INFO - PID 24678 | RSS: Main: 158326784 18:45:39 INFO - PID 24678 | 18:48:40 INFO - PID 24678 | Cycle 1(1): loaded http://localhost:35794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35794/tests/dromaeo/cssquery-mootools.html) 18:48:41 INFO - PID 24678 | RSS: Main: 159526912 18:48:41 INFO - PID 24678 | 18:51:43 INFO - PID 24678 | Cycle 1(1): loaded http://localhost:35794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35794/tests/dromaeo/cssquery-prototype.html) 18:51:43 INFO - PID 24678 | RSS: Main: 159711232 18:51:43 INFO - PID 24678 | 18:54:46 INFO - PID 24678 | Cycle 1(1): loaded http://localhost:35794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35794/tests/dromaeo/cssquery-yui.html) 18:54:47 INFO - PID 24678 | RSS: Main: 161058816 18:54:47 INFO - PID 24678 | 18:57:48 INFO - PID 24678 | Cycle 1(1): loaded http://localhost:35794/tests/dromaeo/cssquery-yui.html (next: http://localhost:35794/tests/dromaeo/cssquery-dojo.html) 18:57:49 INFO - PID 24678 | RSS: Main: 164237312 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | __start_tp_report 18:57:49 INFO - PID 24678 | _x_x_mozilla_page_load 18:57:49 INFO - PID 24678 | _x_x_mozilla_page_load_details 18:57:49 INFO - PID 24678 | |i|pagename|runs| 18:57:49 INFO - PID 24678 | |0;dojo.html;3544.556930383702;3584.211473475836;3588.1388466767976;3592.91017724557;3609.494670746096;6322.146510221119;6383.553151279407;6429.742810287583;6460.870782584351;6466.773662921799;6347.936520634792;6377.04344348348;6449.258335291443;6452.483801295909;6471.352864713526;5490.094134467828;5506.063969125258;5530.806421775239;5613.663180209201;5644.6613203207735;5582.413846546115;5588.189712491686;5650.604457687963;5651.9152212716845;5675.489205971462;5589.133684278923;5597.104463285875;5621.634593751393;5649.802256921009;5671;5488.313960754906;5553.416891226444;5576.944230557683;5609.5792815539;5634.887302253973;5503.477169668875;5541.251930989305;5564.054110801174;5567.415421380737;5587.38538760736;6213;6224.813255602294;6225.937740622627;6275.058741188813;6299.8110056697915;6707.396334329934;6824.488163387716;6839.521233513656;6895.896561551581;6933.479989000794;6884.552504087268;6950.721971121149;6956.200036995709;6967.338102880219;6977.162740471176;6364.236291645032;6382.170317858649;6429.38920802523;6472.223333199999;6495.870082598369;6869.896951545731;6980.441564674814;7003.26465721092;7004.474664400191;7016.122984626922;6697.330266973264;6732.091167692397;6748.763793267212;6753.1220941277315;6764.0530325754435;6783.253842077367;6789.830254243585;6827.2831352708245;6907.585544867324;6916.688749006306;6840.3501667341525;6900.827479313058;6921.515493915478;6929.064576282138;6958.165020197609;6795.490338224554;6804.285550017276;6809.897851532231;6867.107276054081;6884.621345825927;4908.165611845995;5023.974880125649;5029.823956161516;5083.313752643419;5126.436092029874;4596.264597664424;4603.838865639686;4636.235021221528;4641.373414589055;4646.395968524138;6553;6559.344065593403;6624.403803657694;6633.601983880886;6633.900491492632;6873.725050998004;6912.481563882729;6977.546459480118;6978.616176110261;6982.266861979419;6336.873262534724;6440;6572.605643661395;6637.336266373324;6646.169228846395;5836.970815145897;5876.382979787061;5878.030125029408;5880.176775251468;5886.440788125121;7115.82210444743;7122.394596459359;7132.358087772125;7179.138503379628;7198.280171982865;6707.698153583198;6839.384455399038;6850.486213533905;6905.516613836983;6990.720371185095;7102.325279098477;7134.643267836484;7137.286271372821;7143.107111611049;7155;6677.69950352245;6806.897896531457;6838.350356716104;6850.143732033496;6870.27862074475;6779.694913728993;6890.173179218526;6892.896606550806;6957.095577575085;6963.895541566982;6638.900416493853;6725.226598941184;6802.965985170043;6813.4889883257965;6839.2818754032105;6736.124303840469;6782.491313151435;6810.523263371517;6827.692753826189;6831.6242606657115;6553.934460655523;6620.503462240447;6636.668166591555;6739.730410783513;6845.315468453115;6550.967245163743;6576.243731970884;6611.834704132435;6615.305392933673;6642.734290628514;6382.425581697669;6387.073874288295;6392.648404337806;6395.968020159869;6416 18:57:49 INFO - PID 24678 | |1;ext.html;873.3969218926562;916.4409710076856;944.7968686732352;968.3221744778657;973.9366941148825;40883.59116408835;41736.16527669448;41740.37389439161;41754.58245417545;41771.79114104433;38607;39026.80486597563;39153.21693566134;39203.41194882079;39325.80337098318;7112;7198.4601154913325;7224.349808517232;7226.56640601563;7226.963865180666;7038.697840899425;7122.358987691106;7122.430205583567;7131.607761573111;7136.393406560449;7050.788476345718;7619.923800762004;7928.286454219119;7963.9203607963755;7966.4025198110085;7896.921030789705;7922.643481043367;7941.126476087626;7947.245011723935;7950.204979502061;7726.304632583095;7826.256505631955;7835.294823465859;7838.490498117604;7847.5291482510665;40276.79861600703;40482.79758601217;40596.59403405958;40639.18721625551;40643.7967810162;3619.2037751694847;3673.412254039368;3674.8713795017316;3675.3568125577917;3680.650338217865;31999.200019999455;32033.51949720756;32078.03765887027;32079.358412831614;32179.356412871846;5065.442801291855;5130.897382052338;5132.871678208037;5168.302279192336;5183.118869792144;203693;205089;213264;220452;225370.87314563486;51655.22517162246;51751.22373164406;51775.48224517782;51793.7410312946;51847.74076129595;53641.1953820693;53833.730831345594;53852.730736346064;53905;53939.46060539344;17216.397426090276;17246.396376126777;17263.39578114785;17289.13554322279;17449.12754362277;14248.85751142496;14257.50098746539;14257.85742142586;14307.070040447337;14325.85674143266;14995;15130.167840768643;15182.089074655556;15274.618134546725;15299;5855.912161317584;5957.6127551709;6130.386961303834;6173.969130154321;6206.875862482725;1097.8627671541058;1116.1851848150895;1120.6694025262568;1123.5898896902572;1138.5502726423017;25179.62230566543;25328.873355633103;25368.365790855376;25426.364340891254;25631;1181.344353883603;1181.373871847922;1198.5625246785035;1216.173002358387;1228.9078319126102;13397.866021339662;13554.661133471742;13781;13862.584122476343;14010.229437381042;301279;302948;304551;304709;304797;56047.43952560422;56075.71962140163;56076.71961640166;56137.157942630896;56194.71902640461;1501.1593507635541;1515.613518552762;1550.7363748162838;1570.7329753941858;1574.7401678722883;24676.56230510166;24719.25842224736;24875.62686559739;24879.59391674497;24923.75076249214;40494.59505404908;40529.797351013054;40654.1869162621;40832.18335633211;40921.59078409178;252210;253080;253575;253603;253672;32525.674743252264;33287.50068749019;33421.33157336888;34829;34957;44475;44509;44527.55472445234;44654.3301850479;44755.776221118685;33913;34160.31679366448;34169.829150854086;34333.82833085819;34486.655133448345;33904;33968.66031339754;34008.3198336027;34105.65894341124;34404.31191376209;37723.43414848725;37850.43224351692;38073.4288985671;38101.4284785734;38135.2372952545;32498.187545311557;32722.50916236306;32909.67090329162;32934.34131317408;33122.66877331292;24973.250802475955;25015.749842501344;25229.73851307464;25313.746862531876;25682.743172568782 18:57:49 INFO - PID 24678 | |2;jquery.html;598.4404581716099;602.5149754447671;603.1766638538395;620.6276234259448;632.731089287053;22766.544669106606;23366.182183623536;23382.064717411304;23435.5312893742;24268.75731242687;27128.457430851373;27888.721112788866;27929.581056284173;27932.720672793264;27937.720622793768;6354.523410744189;6587.571807832487;6696.129503164581;6749.763758268462;6762.797116086525;6553.115329430513;6577.704003319862;6592.901106483407;6594.934050659504;6600.9339906601035;6484.740610375579;6513.348665133496;6516.218053833547;6558.901616475757;6582.341765823403;6487.545871788977;6502.577332473374;6523.347665233486;6529.869402611945;6532;6125.295591007047;6142.201513803222;6158.7228574714245;6160.784372546939;6161.507079433634;30393.696063039308;31408.685913141035;31466.21334466634;31486.527702084488;31629.683703162904;2233.586786444513;2244.5623103494827;2248.392933907836;2252.749723903233;2253.7746225377496;19826.1078251479;20379.286724964702;20397.89801051;20450;20453.07961141752;2321.1875843454823;2426.793722533587;2447.4003869052017;2447.486027934136;2496.7752902238885;157217;160330.1983490087;160533.19733401257;160925.19537402238;161042;16401.145730753262;16561.751573726404;16672.666546669;16765.161741912856;16971;25828.354291142496;25900.481990360087;25915.481690366087;25953.480930381287;25984.090556830797;10743.677689669323;10902.672919812418;11531.250468719507;11601.651950441501;11786.705332366759;8923.553822308859;9399.624015039322;10560.683179504627;10818.188635852186;10970.780584388267;9909.157721593601;10055.69832905014;10125.544350504246;10311.432871192006;10496.527656255486;2772.6709563966365;2835.688074311824;2903.7676985841504;2932.4868148074;2940.3531223130876;1052.5211028981794;1059.2108878885126;1060.5439660945867;1070.7216123807866;1084.343971896991;21649.242276520246;21698.34904952854;21722.674159887614;21982.780172198072;22162.445938851335;1139.9031082357926;1149.1611123879447;1149.7125718570358;1151.268944220426;1159.09590519395;11938.925496705338;11976.981956533793;12156.149069565046;12163.5134594617;12229.449674764657;602509;611988;625213;628541.4291714232;628850;133032;136850;137474;138410;140087.29956350152;1272.4210484229839;1281.3080936294482;1328.282727327271;1328.3291937571464;1331.4541038174495;19014.61970760605;19195.32816351421;19440.736352137064;19623.60752784965;19749.60500790005;61353.38646613655;63099;63930.68034659983;64108.35891641024;64921.35078649153;75965.62017189879;76806.61596691981;77786;78360;78704.21295787198;14661.780073299122;15839.366425342858;16007.519774406786;16034.518964431085;16073.357065717708;24758.38104047341;24985.250442486755;25134.371640709127;25215.621765673895;25225.24324270275;19936.90031549833;20343.4914127148;20399.4900127498;20418.897905510377;20454.07956641925;17790.555236119202;17902.55243618868;18195.090245487936;18305.450836474927;18482.630347393246;20420.285290014777;20771;20842.791572084087;21143;21172.788272117083;15534.22328883574;15618.687626247638;15649.452269170524;15665.686686265983;15721.606959826096;19500;19582.706259406405;19708.50728731793;19982;20027.599448010667 18:57:49 INFO - PID 24678 | |3;mootools.html;1427.4076258352782;1487.3158347160306;1503.6541595433057;1515.878729701624;1525.6414742535503;15824.920875395635;16074;16451.177441127955;16457.094859782723;16464.917675411638;16814.495565133035;17145.657086858286;17151.228194731237;17152;17200.311987520516;2944.1903476543907;2960.748336391404;2999.0852789899072;3000.5199168133104;3001.83489908055;2882.6540815102217;2942.882284708609;2957.3345997150577;2991.5662228976785;2994.056872085297;2960.689127641599;2983.1199796060214;2983.284011837165;2983.3734915667737;2995.7603391728717;2798.3004248937764;2847.7009913959046;2864.0119158890147;2868.1825679681297;2868.340281735202;2765.4330862173206;2800.7899407544514;2805.957910631342;2823;2824.3362809739697;15790.368385264575;16215;16237.106959117244;16251.431199908066;16274.75587866183;8336.249737523653;8617.224449799549;8656.653733850639;8692.434991725517;8706.521141337224;5357.330333708286;5501.559875210014;5602.2717046783655;5681.886362272731;5697.715114244271;1904.0670071664786;1919.9712004319947;1920.654282229198;1922.1350392323511;1952.5606738483868;27851.721482785117;28099.157025289274;28113.172643778293;28124.437511249864;28152.15543533677;6813.795586132324;7114.537555058904;7115.786526404217;7271.163816161104;7294.416446684252;18652.44042678722;18819.81180188208;18845.340413085476;18906.716399254023;18925.905370473058;8397.202265784741;8508.234258916727;8513.318934485227;8546.05993340732;8554.572271386405;7738.883916741253;7820.882686759704;7867.842643147105;7969.203079691984;7977.641006154737;5193.3767947845745;5801.100829371454;5973.074173503114;6022.879542409215;6040.214772079689;1556.6730986492737;1888.3296429767508;1901.2680118154333;1941.631090092906;1967.1049672399024;998.7752755630071;1021.7088129882948;1028.0747327405395;1030.4590090202703;1040.5629635553087;9616.615335386507;9641.903580964101;9773.657921972697;9824.557894894748;9941.80116397668;1069.8769641491172;1079.8434227037035;1093.9507722152523;1121.876593574706;1124.1063354633086;5912.970435147883;6014.338422773491;6126.326104128542;6219.036049412348;6298.7795427160745;22904.541909162057;23936.52126957451;24079.759202408102;24082;24092.952099071776;22472.651640901597;23236.419089522897;23372.532549348918;23422.297331080095;23521.88239058828;12408;12650.367481625697;12661.746765064647;12693.428795704216;12709.872901271054;8814.603342849716;9458;9462.952685236805;9495.85756213671;9567;19863.70204446963;20158.79841201628;20673.17307307691;21114;21198.788012120298;20461.89769051145;20745.377638670863;20807;20930.68603970911;21132.154713811276;11905.107116966436;12164.08769342285;12266.080043996557;12294.692632684255;12311.938440307742;13086.280254585708;14504.927475362556;14724.337404816595;14762.409503619734;14802.851971480148;12265.38673066361;12338.444769985193;12450.439730211981;12523.874761252635;12554.309512976874;11580.826287605862;11585.710357241136;11685.123615729024;11793.587224447103;11834.76330473403;10559.63041293551;10712.14302855754;10728.785424291314;10742.677719668422;10794.892051079389;8019.679212831421;8141.959290203748;8149.633266502903;8209.09699932995;8225.136360682041;7631.236876312546;7737.187595302412;7782.299593036654;7838.882416763867;7849.097353804157 18:57:49 INFO - PID 24678 | |4;prototype.html;518.9974050129749;541.5640409470376;559.4209992657595;564.6160610784667;567.9602427830052;6137.754489820408;6146.60047096939;6149.569530132892;6151.800398922212;6220.253569571652;5975.372585878475;5985.25184351956;6015.578909476339;6078.422549857756;6118.541109416789;4767.284907263912;4799.880002999918;4802.5197480252045;4816.349792777983;4883.218685010399;4724.952750472486;4803.207470767319;4830.565249127578;4831.54100360467;4835.927461088087;4711.269753188244;4795.136875362434;4809.495003024685;4854;4855.150348688983;4843.975780121094;4845.030993801254;4845.947053356398;4851.417829860404;4875.658703890729;4349.108432771306;4406.581374769392;4421.027373977752;4430.401895744066;4446.244138496463;6048.304444988838;6067.726952287114;6114.327423983358;6122.540809439265;6126.969365153146;5771.711414429262;5832.650040997553;5847.26909136358;5849.181114643953;5851.473367396955;6486.448651864597;6489.513286503531;6512.967435162794;6602.2737498875085;6643.93356066438;4988.127077761377;5006.674566153225;5010.348654674905;5054.898902021976;5073.441921388644;6827.21487028993;6905.792826215222;6915.239323674392;6942.930570694279;6946.3053694630635;5105.642605017613;5149.914284714697;5155.123628983082;5171.896562068813;5180.430152683201;5214.217867319857;5218.921716174261;5270.8155214567305;5272.736363181825;5291.576673866081;5674.375818659944;5739.799107031234;5791.160281759206;5797.304323481209;5827.854303642443;6344.936550634527;6436.839079022968;6451.677416129175;6516.413522782972;6557.868842623121;1729.1699984007746;1734.5056658852166;1787.2484964734374;1791.2118667786133;1813.2565648084221;1246.1214843535286;1274.4756115788912;1291.6770807298176;1297.6042307096427;1303.3222724183372;6187.133801267736;6329.461995730415;6330.430261276507;6367.61794292344;6408.55140140195;6752.392284694303;6790.7623233186605;6805.727770889208;6806.489513286523;6835.111435513351;6329.430351268408;6333;6340.492760579143;6357.300696923335;6369.681515924185;3514.1741690702665;3536.717062634983;3540.150363912642;3557;3583.5878873929832;6845.212800528003;6900.0679809653375;6900.516963812485;6948.722051117999;6950.513464057467;6792.660366981631;6840.384365407137;6861.451083913275;6864.38220560152;6884.586924784428;6911.6544172791155;6933.1333583302085;6933.722651094001;6993.160820701549;7007.544509606859;6702.994550817221;6727.226368967631;6772.424343930821;6800.421964133104;6830.795076147723;6652.700628471827;6658.267590565131;6662;6688.464922806261;6728.529002969941;6991.2309645937885;7000.439964802906;7003.649817509002;7004.303343212798;7017.508774385744;5148.48119804666;5168.224766285088;5177.870553236048;5194.948050519598;5213.13983192769;6471.870562588816;6545.952647576365;6713.429358504582;6743.831404214934;6750.6624668767345;6271.937280627318;6458.22501299847;6511.47908167336;6526.67366631676;6541.182352205974;6374.043893415839;6524.739010439719;6539.574927629689;6548.508861835287;6584.736610535525;6470.6441145737435;6520.282768895512;6538.444232240313;6554.442872355903;6584.045313429621;6554.639494827639;6563.245226798979;6565.901511477427;6597.27429982692;6614.735410583715;6281.40326668984;6330.366963303817;6392.680365981775;6403.839904002437;6414.454771344302 18:57:49 INFO - PID 24678 | |5;yui.html;962.1965658675006;975.1175186456255;1002.108123769845;1010.2372708605002;1016.146436992926;17049.914750426247;17250.82749172508;17327.913360433195;17399.217035233414;17490.38783642573;17537.73693394597;20852.582948341023;20947.685784713205;21404.25085122021;21485;1066.7066556696911;1079.703081652544;1090.2913106480771;1090.607381342716;1090.8091084060259;1090.547422819529;1092.9617463388784;1098.3739268616891;1099.0987390339924;1100.3562915694329;1029.7271223125877;1111;1128.0355296221735;1128.2440764687638;1128.3399211461306;1103.5309993252836;1109.8224284114583;1115.4367044642486;1115.8493603363563;1118.932864028161;815.461795215161;815.5514467043162;817.9509229446252;818.108261994429;819.3240576524331;18435.262589496404;18567.535811604685;18722.157502912403;18751.343702970466;19858.404247872586;21086.683699744517;21211.151553937823;21410.250641227638;21444.24945126913;21768.89115554412;16521.91739041309;16673.333066677318;16800;16848.83151168485;16922.069286189253;3779.130799916007;3810.123671555558;3811.3520701480816;3812.942805857914;3814.771113733185;140058.57273777676;140105.59894401027;141011;141542.29228853894;143329;16474.58813529671;16678.166091695366;16734.330626775038;16738.665226695397;16884.915575422045;32323.19192020218;32619.184520386705;33505.329893402;33572.49641255383;33619.495707564405;8717.912820871838;8722.563871806511;8943.3739638226;8967.775805604912;8977.147171018743;4422.668299877522;4466.263066593976;4497.752623605667;4508;4508.188526065274;5804.1293805929445;5839.211706419664;5924.052151655801;5953.285605727254;5966.075258334965;1219.4756254810516;1233.463443402123;1240.0389697984135;1247.7504499100216;1254.8556915954782;735.1398863329916;762.8931949527071;766.4864540757594;769.342212408394;777.9766607001799;12665.936670316589;13450.327483625779;13690.452381904612;13720.65698357549;13729.588112356645;703.5928143712575;706.7137809187287;714.5998240985065;730.8830587106144;732.5641243460133;6073.48375388097;6167.96916015426;6240.282367527792;6257.812265631947;6657.633830139389;122347.3882630599;128266.35866820606;131525;132181.33909330584;138334;113249;115100.42449787697;116122;118359.40820295844;122014.38992804979;99357;101203.49398252962;101590.49204754077;101931.49034254781;104799;13548.644736185373;13616.795748063589;13660.93169534146;13731.656708582366;13918.234497102352;46622.53377466318;46700.299495506915;46890.53109468862;47340;47649.76175119102;85894.85262868478;87379;88079.1192088071;88509.55745221232;91575;20467.28364507235;20634.484137896074;21641.13435462564;21701.891490542446;22007.339779806633;22320.553588928455;22790.202342917917;22851.31446056621;22879.771202287764;22924.19765308206;20939.790602093784;21437;21455.356339309845;21638.35084947454;21670.783292166878;21314;21548.67676984878;21595.892020539795;21684.24105156312;21812.781872181076;19945.102470389156;21564.568708626055;21715.782842172008;21723.34829955104;21857.89071054698;15017.17405542662;15394.46119385861;15660.451884183998;16170.434034808724;16230.51308460748;14608.269586520419;14752.69416943901;15958.12230327343;16241.269142888363;16509.58726031859 18:57:49 INFO - PID 24678 | __end_tp_report 18:57:49 INFO - PID 24678 | __start_cc_report 18:57:49 INFO - PID 24678 | _x_x_mozilla_cycle_collect,292 18:57:49 INFO - PID 24678 | __end_cc_report 18:57:49 INFO - PID 24678 | __startTimestamp1505959069063__endTimestamp 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | ------- Summary: start ------- 18:57:49 INFO - PID 24678 | Number of tests: 6 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | [#0] dojo.html Cycles:165 Average:6327.44 Median:6633.60 stddev:791.53 (11.9%) stddev-sans-first:763.26 18:57:49 INFO - PID 24678 | Values: 3544.6 3584.2 3588.1 3592.9 3609.5 6322.1 6383.6 6429.7 6460.9 6466.8 6347.9 6377.0 6449.3 6452.5 6471.4 5490.1 5506.1 5530.8 5613.7 5644.7 5582.4 5588.2 5650.6 5651.9 5675.5 5589.1 5597.1 5621.6 5649.8 5671.0 5488.3 5553.4 5576.9 5609.6 5634.9 5503.5 5541.3 5564.1 5567.4 5587.4 6213.0 6224.8 6225.9 6275.1 6299.8 6707.4 6824.5 6839.5 6895.9 6933.5 6884.6 6950.7 6956.2 6967.3 6977.2 6364.2 6382.2 6429.4 6472.2 6495.9 6869.9 6980.4 7003.3 7004.5 7016.1 6697.3 6732.1 6748.8 6753.1 6764.1 6783.3 6789.8 6827.3 6907.6 6916.7 6840.4 6900.8 6921.5 6929.1 6958.2 6795.5 6804.3 6809.9 6867.1 6884.6 4908.2 5024.0 5029.8 5083.3 5126.4 4596.3 4603.8 4636.2 4641.4 4646.4 6553.0 6559.3 6624.4 6633.6 6633.9 6873.7 6912.5 6977.5 6978.6 6982.3 6336.9 6440.0 6572.6 6637.3 6646.2 5837.0 5876.4 5878.0 5880.2 5886.4 7115.8 7122.4 7132.4 7179.1 7198.3 6707.7 6839.4 6850.5 6905.5 6990.7 7102.3 7134.6 7137.3 7143.1 7155.0 6677.7 6806.9 6838.4 6850.1 6870.3 6779.7 6890.2 6892.9 6957.1 6963.9 6638.9 6725.2 6803.0 6813.5 6839.3 6736.1 6782.5 6810.5 6827.7 6831.6 6553.9 6620.5 6636.7 6739.7 6845.3 6551.0 6576.2 6611.8 6615.3 6642.7 6382.4 6387.1 6392.6 6396.0 6416.0 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | [#1] ext.html Cycles:180 Average:42692.38 Median:3646.31 stddev:67658.91 (1855.5%) stddev-sans-first:67775.85 18:57:49 INFO - PID 24678 | Values: 873.4 916.4 944.8 968.3 973.9 40883.6 41736.2 41740.4 41754.6 41771.8 38607.0 39026.8 39153.2 39203.4 39325.8 7112.0 7198.5 7224.3 7226.6 7227.0 7038.7 7122.4 7122.4 7131.6 7136.4 7050.8 7619.9 7928.3 7963.9 7966.4 7896.9 7922.6 7941.1 7947.2 7950.2 7726.3 7826.3 7835.3 7838.5 7847.5 40276.8 40482.8 40596.6 40639.2 40643.8 3619.2 3673.4 3674.9 3675.4 3680.7 31999.2 32033.5 32078.0 32079.4 32179.4 5065.4 5130.9 5132.9 5168.3 5183.1 203693.0 205089.0 213264.0 220452.0 225370.9 51655.2 51751.2 51775.5 51793.7 51847.7 53641.2 53833.7 53852.7 53905.0 53939.5 17216.4 17246.4 17263.4 17289.1 17449.1 14248.9 14257.5 14257.9 14307.1 14325.9 14995.0 15130.2 15182.1 15274.6 15299.0 5855.9 5957.6 6130.4 6174.0 6206.9 1097.9 1116.2 1120.7 1123.6 1138.6 25179.6 25328.9 25368.4 25426.4 25631.0 1181.3 1181.4 1198.6 1216.2 1228.9 13397.9 13554.7 13781.0 13862.6 14010.2 301279.0 302948.0 304551.0 304709.0 304797.0 56047.4 56075.7 56076.7 56137.2 56194.7 1501.2 1515.6 1550.7 1570.7 1574.7 24676.6 24719.3 24875.6 24879.6 24923.8 40494.6 40529.8 40654.2 40832.2 40921.6 252210.0 253080.0 253575.0 253603.0 253672.0 32525.7 33287.5 33421.3 34829.0 34957.0 44475.0 44509.0 44527.6 44654.3 44755.8 33913.0 34160.3 34169.8 34333.8 34486.7 33904.0 33968.7 34008.3 34105.7 34404.3 37723.4 37850.4 38073.4 38101.4 38135.2 32498.2 32722.5 32909.7 32934.3 33122.7 24973.3 25015.7 25229.7 25313.7 25682.7 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | [#2] jquery.html Cycles:180 Average:40765.27 Median:22072.61 stddev:103884.48 (470.6%) stddev-sans-first:104132.12 18:57:49 INFO - PID 24678 | Values: 598.4 602.5 603.2 620.6 632.7 22766.5 23366.2 23382.1 23435.5 24268.8 27128.5 27888.7 27929.6 27932.7 27937.7 6354.5 6587.6 6696.1 6749.8 6762.8 6553.1 6577.7 6592.9 6594.9 6600.9 6484.7 6513.3 6516.2 6558.9 6582.3 6487.5 6502.6 6523.3 6529.9 6532.0 6125.3 6142.2 6158.7 6160.8 6161.5 30393.7 31408.7 31466.2 31486.5 31629.7 2233.6 2244.6 2248.4 2252.7 2253.8 19826.1 20379.3 20397.9 20450.0 20453.1 2321.2 2426.8 2447.4 2447.5 2496.8 157217.0 160330.2 160533.2 160925.2 161042.0 16401.1 16561.8 16672.7 16765.2 16971.0 25828.4 25900.5 25915.5 25953.5 25984.1 10743.7 10902.7 11531.3 11601.7 11786.7 8923.6 9399.6 10560.7 10818.2 10970.8 9909.2 10055.7 10125.5 10311.4 10496.5 2772.7 2835.7 2903.8 2932.5 2940.4 1052.5 1059.2 1060.5 1070.7 1084.3 21649.2 21698.3 21722.7 21982.8 22162.4 1139.9 1149.2 1149.7 1151.3 1159.1 11938.9 11977.0 12156.1 12163.5 12229.4 602509.0 611988.0 625213.0 628541.4 628850.0 133032.0 136850.0 137474.0 138410.0 140087.3 1272.4 1281.3 1328.3 1328.3 1331.5 19014.6 19195.3 19440.7 19623.6 19749.6 61353.4 63099.0 63930.7 64108.4 64921.4 75965.6 76806.6 77786.0 78360.0 78704.2 14661.8 15839.4 16007.5 16034.5 16073.4 24758.4 24985.3 25134.4 25215.6 25225.2 19936.9 20343.5 20399.5 20418.9 20454.1 17790.6 17902.6 18195.1 18305.5 18482.6 20420.3 20771.0 20842.8 21143.0 21172.8 15534.2 15618.7 15649.5 15665.7 15721.6 19500.0 19582.7 19708.5 19982.0 20027.6 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | [#3] mootools.html Cycles:180 Average:10151.26 Median:24008.14 stddev:7208.90 (30.0%) stddev-sans-first:7199.32 18:57:49 INFO - PID 24678 | Values: 1427.4 1487.3 1503.7 1515.9 1525.6 15824.9 16074.0 16451.2 16457.1 16464.9 16814.5 17145.7 17151.2 17152.0 17200.3 2944.2 2960.7 2999.1 3000.5 3001.8 2882.7 2942.9 2957.3 2991.6 2994.1 2960.7 2983.1 2983.3 2983.4 2995.8 2798.3 2847.7 2864.0 2868.2 2868.3 2765.4 2800.8 2806.0 2823.0 2824.3 15790.4 16215.0 16237.1 16251.4 16274.8 8336.2 8617.2 8656.7 8692.4 8706.5 5357.3 5501.6 5602.3 5681.9 5697.7 1904.1 1920.0 1920.7 1922.1 1952.6 27851.7 28099.2 28113.2 28124.4 28152.2 6813.8 7114.5 7115.8 7271.2 7294.4 18652.4 18819.8 18845.3 18906.7 18925.9 8397.2 8508.2 8513.3 8546.1 8554.6 7738.9 7820.9 7867.8 7969.2 7977.6 5193.4 5801.1 5973.1 6022.9 6040.2 1556.7 1888.3 1901.3 1941.6 1967.1 998.8 1021.7 1028.1 1030.5 1040.6 9616.6 9641.9 9773.7 9824.6 9941.8 1069.9 1079.8 1094.0 1121.9 1124.1 5913.0 6014.3 6126.3 6219.0 6298.8 22904.5 23936.5 24079.8 24082.0 24093.0 22472.7 23236.4 23372.5 23422.3 23521.9 12408.0 12650.4 12661.7 12693.4 12709.9 8814.6 9458.0 9463.0 9495.9 9567.0 19863.7 20158.8 20673.2 21114.0 21198.8 20461.9 20745.4 20807.0 20930.7 21132.2 11905.1 12164.1 12266.1 12294.7 12311.9 13086.3 14504.9 14724.3 14762.4 14802.9 12265.4 12338.4 12450.4 12523.9 12554.3 11580.8 11585.7 11685.1 11793.6 11834.8 10559.6 10712.1 10728.8 10742.7 10794.9 8019.7 8142.0 8149.6 8209.1 8225.1 7631.2 7737.2 7782.3 7838.9 7849.1 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | [#4] prototype.html Cycles:180 Average:5582.91 Median:6246.10 stddev:1578.04 (25.3%) stddev-sans-first:1536.01 18:57:49 INFO - PID 24678 | Values: 519.0 541.6 559.4 564.6 568.0 6137.8 6146.6 6149.6 6151.8 6220.3 5975.4 5985.3 6015.6 6078.4 6118.5 4767.3 4799.9 4802.5 4816.3 4883.2 4725.0 4803.2 4830.6 4831.5 4835.9 4711.3 4795.1 4809.5 4854.0 4855.2 4844.0 4845.0 4845.9 4851.4 4875.7 4349.1 4406.6 4421.0 4430.4 4446.2 6048.3 6067.7 6114.3 6122.5 6127.0 5771.7 5832.7 5847.3 5849.2 5851.5 6486.4 6489.5 6513.0 6602.3 6643.9 4988.1 5006.7 5010.3 5054.9 5073.4 6827.2 6905.8 6915.2 6942.9 6946.3 5105.6 5149.9 5155.1 5171.9 5180.4 5214.2 5218.9 5270.8 5272.7 5291.6 5674.4 5739.8 5791.2 5797.3 5827.9 6344.9 6436.8 6451.7 6516.4 6557.9 1729.2 1734.5 1787.2 1791.2 1813.3 1246.1 1274.5 1291.7 1297.6 1303.3 6187.1 6329.5 6330.4 6367.6 6408.6 6752.4 6790.8 6805.7 6806.5 6835.1 6329.4 6333.0 6340.5 6357.3 6369.7 3514.2 3536.7 3540.2 3557.0 3583.6 6845.2 6900.1 6900.5 6948.7 6950.5 6792.7 6840.4 6861.5 6864.4 6884.6 6911.7 6933.1 6933.7 6993.2 7007.5 6703.0 6727.2 6772.4 6800.4 6830.8 6652.7 6658.3 6662.0 6688.5 6728.5 6991.2 7000.4 7003.6 7004.3 7017.5 5148.5 5168.2 5177.9 5194.9 5213.1 6471.9 6546.0 6713.4 6743.8 6750.7 6271.9 6458.2 6511.5 6526.7 6541.2 6374.0 6524.7 6539.6 6548.5 6584.7 6470.6 6520.3 6538.4 6554.4 6584.0 6554.6 6563.2 6565.9 6597.3 6614.7 6281.4 6330.4 6392.7 6403.8 6414.5 18:57:49 INFO - PID 24678 | 18:57:49 INFO - PID 24678 | [#5] yui.html Cycles:180 Average:27098.13 Median:20743.53 stddev:37830.84 (182.4%) stddev-sans-first:37886.06 18:57:49 INFO - PID 24678 | Values: 962.2 975.1 1002.1 1010.2 1016.1 17049.9 17250.8 17327.9 17399.2 17490.4 17537.7 20852.6 20947.7 21404.3 21485.0 1066.7 1079.7 1090.3 1090.6 1090.8 1090.5 1093.0 1098.4 1099.1 1100.4 1029.7 1111.0 1128.0 1128.2 1128.3 1103.5 1109.8 1115.4 1115.8 1118.9 815.5 815.6 818.0 818.1 819.3 18435.3 18567.5 18722.2 18751.3 19858.4 21086.7 21211.2 21410.3 21444.2 21768.9 16521.9 16673.3 16800.0 16848.8 16922.1 3779.1 3810.1 3811.4 3812.9 3814.8 140058.6 140105.6 141011.0 141542.3 143329.0 16474.6 16678.2 16734.3 16738.7 16884.9 32323.2 32619.2 33505.3 33572.5 33619.5 8717.9 8722.6 8943.4 8967.8 8977.1 4422.7 4466.3 4497.8 4508.0 4508.2 5804.1 5839.2 5924.1 5953.3 5966.1 1219.5 1233.5 1240.0 1247.8 1254.9 735.1 762.9 766.5 769.3 778.0 12665.9 13450.3 13690.5 13720.7 13729.6 703.6 706.7 714.6 730.9 732.6 6073.5 6168.0 6240.3 6257.8 6657.6 122347.4 128266.4 131525.0 132181.3 138334.0 113249.0 115100.4 116122.0 118359.4 122014.4 99357.0 101203.5 101590.5 101931.5 104799.0 13548.6 13616.8 13660.9 13731.7 13918.2 46622.5 46700.3 46890.5 47340.0 47649.8 85894.9 87379.0 88079.1 88509.6 91575.0 20467.3 20634.5 21641.1 21701.9 22007.3 22320.6 22790.2 22851.3 22879.8 22924.2 20939.8 21437.0 21455.4 21638.4 21670.8 21314.0 21548.7 21595.9 21684.2 21812.8 19945.1 21564.6 21715.8 21723.3 21857.9 15017.2 15394.5 15660.5 16170.4 16230.5 14608.3 14752.7 15958.1 16241.3 16509.6 18:57:49 INFO - PID 24678 | -------- Summary: end -------- 18:57:49 INFO - PID 24678 | 18:57:49 INFO - TEST-INFO | 24678: exit 0 18:57:49 INFO - TEST-OK | dromaeo_css | took 1108551ms 18:57:49 INFO - TEST-START | kraken 18:57:49 INFO - Initialising browser for kraken test... 18:57:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35794/getInfo.html -profile /tmp/tmpavuP9E/profile 18:57:49 INFO - TEST-INFO | started process 25033 (/builds/slave/test/build/application/firefox/firefox http://localhost:35794/getInfo.html) 18:57:55 INFO - TEST-INFO | 25033: exit 0 18:57:55 INFO - Browser initialized. 18:57:55 INFO - Running cycle 1/1 for kraken test... 18:57:55 INFO - TEST-INFO | started process 25197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavuP9E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:06 INFO - PID 25197 | RSS: Main: 150966272 18:58:06 INFO - PID 25197 | 18:58:09 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35794/tests/kraken/driver.html?testName=audio-beat-detection) 18:58:10 INFO - PID 25197 | RSS: Main: 157835264 18:58:10 INFO - PID 25197 | 18:58:12 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35794/tests/kraken/driver.html?testName=audio-dft) 18:58:13 INFO - PID 25197 | RSS: Main: 159117312 18:58:13 INFO - PID 25197 | 18:58:16 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35794/tests/kraken/driver.html?testName=audio-fft) 18:58:16 INFO - PID 25197 | RSS: Main: 158982144 18:58:16 INFO - PID 25197 | 18:58:18 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35794/tests/kraken/driver.html?testName=audio-oscillator) 18:58:19 INFO - PID 25197 | RSS: Main: 159346688 18:58:19 INFO - PID 25197 | 18:58:21 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35794/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:58:22 INFO - PID 25197 | RSS: Main: 159567872 18:58:22 INFO - PID 25197 | 18:58:25 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35794/tests/kraken/driver.html?testName=imaging-darkroom) 18:58:25 INFO - PID 25197 | RSS: Main: 158875648 18:58:25 INFO - PID 25197 | 18:58:29 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35794/tests/kraken/driver.html?testName=imaging-desaturate) 18:58:29 INFO - PID 25197 | RSS: Main: 161959936 18:58:29 INFO - PID 25197 | 18:58:32 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35794/tests/kraken/driver.html?testName=json-parse-financial) 18:58:33 INFO - PID 25197 | RSS: Main: 162209792 18:58:33 INFO - PID 25197 | 18:58:34 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35794/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:35 INFO - PID 25197 | RSS: Main: 162422784 18:58:35 INFO - PID 25197 | 18:58:36 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:37 INFO - PID 25197 | RSS: Main: 162226176 18:58:37 INFO - PID 25197 | 18:58:39 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:40 INFO - PID 25197 | RSS: Main: 161869824 18:58:40 INFO - PID 25197 | 18:58:42 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:43 INFO - PID 25197 | RSS: Main: 161935360 18:58:43 INFO - PID 25197 | 18:58:46 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:46 INFO - PID 25197 | RSS: Main: 162689024 18:58:46 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | Cycle 1(1): loaded http://localhost:35794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35794/tests/kraken/driver.html?testName=ai-astar) 18:58:48 INFO - PID 25197 | RSS: Main: 164442112 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | __start_tp_report 18:58:48 INFO - PID 25197 | _x_x_mozilla_page_load 18:58:48 INFO - PID 25197 | _x_x_mozilla_page_load_details 18:58:48 INFO - PID 25197 | |i|pagename|runs| 18:58:48 INFO - PID 25197 | |0;ai-astar;97;106;98;107;106;108;107;101;106;110 18:58:48 INFO - PID 25197 | |1;audio-beat-detection;142;116;134;170;112;146;143;114;171;115 18:58:48 INFO - PID 25197 | |2;audio-dft;162;164;162;164;162;161;162;160;163;164 18:58:48 INFO - PID 25197 | |3;audio-fft;75;73;76;183;76;74;74;74;166;77 18:58:48 INFO - PID 25197 | |4;audio-oscillator;78;78;125;78;78;77;130;79;78;129 18:58:48 INFO - PID 25197 | |5;imaging-gaussian-blur;113;113;114;114;117;113;117;116;114;116 18:58:48 INFO - PID 25197 | |6;imaging-darkroom;149;148;148;147;149;149;148;147;148;148 18:58:48 INFO - PID 25197 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;94 18:58:48 INFO - PID 25197 | |8;json-parse-financial;46;45;49;45;49;50;55;45;45;46 18:58:48 INFO - PID 25197 | |9;json-stringify-tinderbox;53;53;52;53;53;53;53;52;52;53 18:58:48 INFO - PID 25197 | |10;stanford-crypto-aes;72;72;80;73;73;71;78;73;73;79 18:58:48 INFO - PID 25197 | |11;stanford-crypto-ccm;114;119;117;119;118;119;131;118;117;156 18:58:48 INFO - PID 25197 | |12;stanford-crypto-pbkdf2;161;158;161;160;162;155;158;159;162;157 18:58:48 INFO - PID 25197 | |13;stanford-crypto-sha256-iterative;58;58;59;58;57;59;57;59;62;56 18:58:48 INFO - PID 25197 | __end_tp_report 18:58:48 INFO - PID 25197 | __start_cc_report 18:58:48 INFO - PID 25197 | _x_x_mozilla_cycle_collect,794 18:58:48 INFO - PID 25197 | __end_cc_report 18:58:48 INFO - PID 25197 | __startTimestamp1505959128739__endTimestamp 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | ------- Summary: start ------- 18:58:48 INFO - PID 25197 | Number of tests: 14 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#0] ai-astar Cycles:10 Average:104.60 Median:107.50 stddev:4.38 (4.1%) stddev-sans-first:3.68 18:58:48 INFO - PID 25197 | Values: 97.0 106.0 98.0 107.0 106.0 108.0 107.0 101.0 106.0 110.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:142.50 stddev:22.29 (15.6%) stddev-sans-first:23.54 18:58:48 INFO - PID 25197 | Values: 142.0 116.0 134.0 170.0 112.0 146.0 143.0 114.0 171.0 115.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 18:58:48 INFO - PID 25197 | Values: 162.0 164.0 162.0 164.0 162.0 161.0 162.0 160.0 163.0 164.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#3] audio-fft Cycles:10 Average:94.80 Median:74.50 stddev:42.21 (56.7%) stddev-sans-first:44.16 18:58:48 INFO - PID 25197 | Values: 75.0 73.0 76.0 183.0 76.0 74.0 74.0 74.0 166.0 77.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:24.19 (31.0%) stddev-sans-first:25.04 18:58:48 INFO - PID 25197 | Values: 78.0 78.0 125.0 78.0 78.0 77.0 130.0 79.0 78.0 129.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:1.64 (1.4%) stddev-sans-first:1.62 18:58:48 INFO - PID 25197 | Values: 113.0 113.0 114.0 114.0 117.0 113.0 117.0 116.0 114.0 116.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 18:58:48 INFO - PID 25197 | Values: 149.0 148.0 148.0 147.0 149.0 149.0 148.0 147.0 148.0 148.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:58:48 INFO - PID 25197 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:3.27 (6.9%) stddev-sans-first:3.43 18:58:48 INFO - PID 25197 | Values: 46.0 45.0 49.0 45.0 49.0 50.0 55.0 45.0 45.0 46.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 18:58:48 INFO - PID 25197 | Values: 53.0 53.0 52.0 53.0 53.0 53.0 53.0 52.0 52.0 53.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.00 stddev:3.27 (4.5%) stddev-sans-first:3.35 18:58:48 INFO - PID 25197 | Values: 72.0 72.0 80.0 73.0 73.0 71.0 78.0 73.0 73.0 79.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:119.00 stddev:12.49 (10.5%) stddev-sans-first:12.83 18:58:48 INFO - PID 25197 | Values: 114.0 119.0 117.0 119.0 118.0 119.0 131.0 118.0 117.0 156.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.50 stddev:2.31 (1.4%) stddev-sans-first:2.37 18:58:48 INFO - PID 25197 | Values: 161.0 158.0 161.0 160.0 162.0 155.0 158.0 159.0 162.0 157.0 18:58:48 INFO - PID 25197 | 18:58:48 INFO - PID 25197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.30 Median:58.50 stddev:1.64 (2.8%) stddev-sans-first:1.73 18:58:48 INFO - PID 25197 | Values: 58.0 58.0 59.0 58.0 57.0 59.0 57.0 59.0 62.0 56.0 18:58:48 INFO - PID 25197 | -------- Summary: end -------- 18:58:48 INFO - PID 25197 | 18:58:49 INFO - PID 25197 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:58:49 INFO - TEST-INFO | 25197: exit 0 18:58:49 INFO - TEST-OK | kraken | took 59785ms 18:58:49 INFO - SUITE-END | took 1168s 18:58:49 INFO - Completed test suite (00:19:28) 18:58:49 INFO - javascript benchmark 18:58:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9064.93248102793, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3544.556930383702, 3584.211473475836, 3588.1388466767976, 3592.91017724557, 3609.494670746096, 6322.146510221119, 6383.553151279407, 6429.742810287583, 6460.870782584351, 6466.773662921799, 6347.936520634792, 6377.04344348348, 6449.258335291443, 6452.483801295909, 6471.352864713526, 5490.094134467828, 5506.063969125258, 5530.806421775239, 5613.663180209201, 5644.6613203207735, 5582.413846546115, 5588.189712491686, 5650.604457687963, 5651.9152212716845, 5675.489205971462, 5589.133684278923, 5597.104463285875, 5621.634593751393, 5649.802256921009, 5671.0, 5488.313960754906, 5553.416891226444, 5576.944230557683, 5609.5792815539, 5634.887302253973, 5503.477169668875, 5541.251930989305, 5564.054110801174, 5567.415421380737, 5587.38538760736, 6213.0, 6224.813255602294, 6225.937740622627, 6275.058741188813, 6299.8110056697915, 6707.396334329934, 6824.488163387716, 6839.521233513656, 6895.896561551581, 6933.479989000794, 6884.552504087268, 6950.721971121149, 6956.200036995709, 6967.338102880219, 6977.162740471176, 6364.236291645032, 6382.170317858649, 6429.38920802523, 6472.223333199999, 6495.870082598369, 6869.896951545731, 6980.441564674814, 7003.26465721092, 7004.474664400191, 7016.122984626922, 6697.330266973264, 6732.091167692397, 6748.763793267212, 6753.1220941277315, 6764.0530325754435, 6783.253842077367, 6789.830254243585, 6827.2831352708245, 6907.585544867324, 6916.688749006306, 6840.3501667341525, 6900.827479313058, 6921.515493915478, 6929.064576282138, 6958.165020197609, 6795.490338224554, 6804.285550017276, 6809.897851532231, 6867.107276054081, 6884.621345825927, 4908.165611845995, 5023.974880125649, 5029.823956161516, 5083.313752643419, 5126.436092029874, 4596.264597664424, 4603.838865639686, 4636.235021221528, 4641.373414589055, 4646.395968524138, 6553.0, 6559.344065593403, 6624.403803657694, 6633.601983880886, 6633.900491492632, 6873.725050998004, 6912.481563882729, 6977.546459480118, 6978.616176110261, 6982.266861979419, 6336.873262534724, 6440.0, 6572.605643661395, 6637.336266373324, 6646.169228846395, 5836.970815145897, 5876.382979787061, 5878.030125029408, 5880.176775251468, 5886.440788125121, 7115.82210444743, 7122.394596459359, 7132.358087772125, 7179.138503379628, 7198.280171982865, 6707.698153583198, 6839.384455399038, 6850.486213533905, 6905.516613836983, 6990.720371185095, 7102.325279098477, 7134.643267836484, 7137.286271372821, 7143.107111611049, 7155.0, 6677.69950352245, 6806.897896531457, 6838.350356716104, 6850.143732033496, 6870.27862074475, 6779.694913728993, 6890.173179218526, 6892.896606550806, 6957.095577575085, 6963.895541566982, 6638.900416493853, 6725.226598941184, 6802.965985170043, 6813.4889883257965, 6839.2818754032105, 6736.124303840469, 6782.491313151435, 6810.523263371517, 6827.692753826189, 6831.6242606657115, 6553.934460655523, 6620.503462240447, 6636.668166591555, 6739.730410783513, 6845.315468453115, 6550.967245163743, 6576.243731970884, 6611.834704132435, 6615.305392933673, 6642.734290628514, 6382.425581697669, 6387.073874288295, 6392.648404337806, 6395.968020159869, 6416.0], "value": 6268.867142470027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.3969218926562, 916.4409710076856, 944.7968686732352, 968.3221744778657, 973.9366941148825, 40883.59116408835, 41736.16527669448, 41740.37389439161, 41754.58245417545, 41771.79114104433, 38607.0, 39026.80486597563, 39153.21693566134, 39203.41194882079, 39325.80337098318, 7112.0, 7198.4601154913325, 7224.349808517232, 7226.56640601563, 7226.963865180666, 7038.697840899425, 7122.358987691106, 7122.430205583567, 7131.607761573111, 7136.393406560449, 7050.788476345718, 7619.923800762004, 7928.286454219119, 7963.9203607963755, 7966.4025198110085, 7896.921030789705, 7922.643481043367, 7941.126476087626, 7947.245011723935, 7950.204979502061, 7726.304632583095, 7826.256505631955, 7835.294823465859, 7838.490498117604, 7847.5291482510665, 40276.79861600703, 40482.79758601217, 40596.59403405958, 40639.18721625551, 40643.7967810162, 3619.2037751694847, 3673.412254039368, 3674.8713795017316, 3675.3568125577917, 3680.650338217865, 31999.200019999455, 32033.51949720756, 32078.03765887027, 32079.358412831614, 32179.356412871846, 5065.442801291855, 5130.897382052338, 5132.871678208037, 5168.302279192336, 5183.118869792144, 203693.0, 205089.0, 213264.0, 220452.0, 225370.87314563486, 51655.22517162246, 51751.22373164406, 51775.48224517782, 51793.7410312946, 51847.74076129595, 53641.1953820693, 53833.730831345594, 53852.730736346064, 53905.0, 53939.46060539344, 17216.397426090276, 17246.396376126777, 17263.39578114785, 17289.13554322279, 17449.12754362277, 14248.85751142496, 14257.50098746539, 14257.85742142586, 14307.070040447337, 14325.85674143266, 14995.0, 15130.167840768643, 15182.089074655556, 15274.618134546725, 15299.0, 5855.912161317584, 5957.6127551709, 6130.386961303834, 6173.969130154321, 6206.875862482725, 1097.8627671541058, 1116.1851848150895, 1120.6694025262568, 1123.5898896902572, 1138.5502726423017, 25179.62230566543, 25328.873355633103, 25368.365790855376, 25426.364340891254, 25631.0, 1181.344353883603, 1181.373871847922, 1198.5625246785035, 1216.173002358387, 1228.9078319126102, 13397.866021339662, 13554.661133471742, 13781.0, 13862.584122476343, 14010.229437381042, 301279.0, 302948.0, 304551.0, 304709.0, 304797.0, 56047.43952560422, 56075.71962140163, 56076.71961640166, 56137.157942630896, 56194.71902640461, 1501.1593507635541, 1515.613518552762, 1550.7363748162838, 1570.7329753941858, 1574.7401678722883, 24676.56230510166, 24719.25842224736, 24875.62686559739, 24879.59391674497, 24923.75076249214, 40494.59505404908, 40529.797351013054, 40654.1869162621, 40832.18335633211, 40921.59078409178, 252210.0, 253080.0, 253575.0, 253603.0, 253672.0, 32525.674743252264, 33287.50068749019, 33421.33157336888, 34829.0, 34957.0, 44475.0, 44509.0, 44527.55472445234, 44654.3301850479, 44755.776221118685, 33913.0, 34160.31679366448, 34169.829150854086, 34333.82833085819, 34486.655133448345, 33904.0, 33968.66031339754, 34008.3198336027, 34105.65894341124, 34404.31191376209, 37723.43414848725, 37850.43224351692, 38073.4288985671, 38101.4284785734, 38135.2372952545, 32498.187545311557, 32722.50916236306, 32909.67090329162, 32934.34131317408, 33122.66877331292, 24973.250802475955, 25015.749842501344, 25229.73851307464, 25313.746862531876, 25682.743172568782], "value": 18164.32155106007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4404581716099, 602.5149754447671, 603.1766638538395, 620.6276234259448, 632.731089287053, 22766.544669106606, 23366.182183623536, 23382.064717411304, 23435.5312893742, 24268.75731242687, 27128.457430851373, 27888.721112788866, 27929.581056284173, 27932.720672793264, 27937.720622793768, 6354.523410744189, 6587.571807832487, 6696.129503164581, 6749.763758268462, 6762.797116086525, 6553.115329430513, 6577.704003319862, 6592.901106483407, 6594.934050659504, 6600.9339906601035, 6484.740610375579, 6513.348665133496, 6516.218053833547, 6558.901616475757, 6582.341765823403, 6487.545871788977, 6502.577332473374, 6523.347665233486, 6529.869402611945, 6532.0, 6125.295591007047, 6142.201513803222, 6158.7228574714245, 6160.784372546939, 6161.507079433634, 30393.696063039308, 31408.685913141035, 31466.21334466634, 31486.527702084488, 31629.683703162904, 2233.586786444513, 2244.5623103494827, 2248.392933907836, 2252.749723903233, 2253.7746225377496, 19826.1078251479, 20379.286724964702, 20397.89801051, 20450.0, 20453.07961141752, 2321.1875843454823, 2426.793722533587, 2447.4003869052017, 2447.486027934136, 2496.7752902238885, 157217.0, 160330.1983490087, 160533.19733401257, 160925.19537402238, 161042.0, 16401.145730753262, 16561.751573726404, 16672.666546669, 16765.161741912856, 16971.0, 25828.354291142496, 25900.481990360087, 25915.481690366087, 25953.480930381287, 25984.090556830797, 10743.677689669323, 10902.672919812418, 11531.250468719507, 11601.651950441501, 11786.705332366759, 8923.553822308859, 9399.624015039322, 10560.683179504627, 10818.188635852186, 10970.780584388267, 9909.157721593601, 10055.69832905014, 10125.544350504246, 10311.432871192006, 10496.527656255486, 2772.6709563966365, 2835.688074311824, 2903.7676985841504, 2932.4868148074, 2940.3531223130876, 1052.5211028981794, 1059.2108878885126, 1060.5439660945867, 1070.7216123807866, 1084.343971896991, 21649.242276520246, 21698.34904952854, 21722.674159887614, 21982.780172198072, 22162.445938851335, 1139.9031082357926, 1149.1611123879447, 1149.7125718570358, 1151.268944220426, 1159.09590519395, 11938.925496705338, 11976.981956533793, 12156.149069565046, 12163.5134594617, 12229.449674764657, 602509.0, 611988.0, 625213.0, 628541.4291714232, 628850.0, 133032.0, 136850.0, 137474.0, 138410.0, 140087.29956350152, 1272.4210484229839, 1281.3080936294482, 1328.282727327271, 1328.3291937571464, 1331.4541038174495, 19014.61970760605, 19195.32816351421, 19440.736352137064, 19623.60752784965, 19749.60500790005, 61353.38646613655, 63099.0, 63930.68034659983, 64108.35891641024, 64921.35078649153, 75965.62017189879, 76806.61596691981, 77786.0, 78360.0, 78704.21295787198, 14661.780073299122, 15839.366425342858, 16007.519774406786, 16034.518964431085, 16073.357065717708, 24758.38104047341, 24985.250442486755, 25134.371640709127, 25215.621765673895, 25225.24324270275, 19936.90031549833, 20343.4914127148, 20399.4900127498, 20418.897905510377, 20454.07956641925, 17790.555236119202, 17902.55243618868, 18195.090245487936, 18305.450836474927, 18482.630347393246, 20420.285290014777, 20771.0, 20842.791572084087, 21143.0, 21172.788272117083, 15534.22328883574, 15618.687626247638, 15649.452269170524, 15665.686686265983, 15721.606959826096, 19500.0, 19582.706259406405, 19708.50728731793, 19982.0, 20027.599448010667], "value": 12975.367826504564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.4076258352782, 1487.3158347160306, 1503.6541595433057, 1515.878729701624, 1525.6414742535503, 15824.920875395635, 16074.0, 16451.177441127955, 16457.094859782723, 16464.917675411638, 16814.495565133035, 17145.657086858286, 17151.228194731237, 17152.0, 17200.311987520516, 2944.1903476543907, 2960.748336391404, 2999.0852789899072, 3000.5199168133104, 3001.83489908055, 2882.6540815102217, 2942.882284708609, 2957.3345997150577, 2991.5662228976785, 2994.056872085297, 2960.689127641599, 2983.1199796060214, 2983.284011837165, 2983.3734915667737, 2995.7603391728717, 2798.3004248937764, 2847.7009913959046, 2864.0119158890147, 2868.1825679681297, 2868.340281735202, 2765.4330862173206, 2800.7899407544514, 2805.957910631342, 2823.0, 2824.3362809739697, 15790.368385264575, 16215.0, 16237.106959117244, 16251.431199908066, 16274.75587866183, 8336.249737523653, 8617.224449799549, 8656.653733850639, 8692.434991725517, 8706.521141337224, 5357.330333708286, 5501.559875210014, 5602.2717046783655, 5681.886362272731, 5697.715114244271, 1904.0670071664786, 1919.9712004319947, 1920.654282229198, 1922.1350392323511, 1952.5606738483868, 27851.721482785117, 28099.157025289274, 28113.172643778293, 28124.437511249864, 28152.15543533677, 6813.795586132324, 7114.537555058904, 7115.786526404217, 7271.163816161104, 7294.416446684252, 18652.44042678722, 18819.81180188208, 18845.340413085476, 18906.716399254023, 18925.905370473058, 8397.202265784741, 8508.234258916727, 8513.318934485227, 8546.05993340732, 8554.572271386405, 7738.883916741253, 7820.882686759704, 7867.842643147105, 7969.203079691984, 7977.641006154737, 5193.3767947845745, 5801.100829371454, 5973.074173503114, 6022.879542409215, 6040.214772079689, 1556.6730986492737, 1888.3296429767508, 1901.2680118154333, 1941.631090092906, 1967.1049672399024, 998.7752755630071, 1021.7088129882948, 1028.0747327405395, 1030.4590090202703, 1040.5629635553087, 9616.615335386507, 9641.903580964101, 9773.657921972697, 9824.557894894748, 9941.80116397668, 1069.8769641491172, 1079.8434227037035, 1093.9507722152523, 1121.876593574706, 1124.1063354633086, 5912.970435147883, 6014.338422773491, 6126.326104128542, 6219.036049412348, 6298.7795427160745, 22904.541909162057, 23936.52126957451, 24079.759202408102, 24082.0, 24092.952099071776, 22472.651640901597, 23236.419089522897, 23372.532549348918, 23422.297331080095, 23521.88239058828, 12408.0, 12650.367481625697, 12661.746765064647, 12693.428795704216, 12709.872901271054, 8814.603342849716, 9458.0, 9462.952685236805, 9495.85756213671, 9567.0, 19863.70204446963, 20158.79841201628, 20673.17307307691, 21114.0, 21198.788012120298, 20461.89769051145, 20745.377638670863, 20807.0, 20930.68603970911, 21132.154713811276, 11905.107116966436, 12164.08769342285, 12266.080043996557, 12294.692632684255, 12311.938440307742, 13086.280254585708, 14504.927475362556, 14724.337404816595, 14762.409503619734, 14802.851971480148, 12265.38673066361, 12338.444769985193, 12450.439730211981, 12523.874761252635, 12554.309512976874, 11580.826287605862, 11585.710357241136, 11685.123615729024, 11793.587224447103, 11834.76330473403, 10559.63041293551, 10712.14302855754, 10728.785424291314, 10742.677719668422, 10794.892051079389, 8019.679212831421, 8141.959290203748, 8149.633266502903, 8209.09699932995, 8225.136360682041, 7631.236876312546, 7737.187595302412, 7782.299593036654, 7838.882416763867, 7849.097353804157], "value": 7289.436210931741, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.9974050129749, 541.5640409470376, 559.4209992657595, 564.6160610784667, 567.9602427830052, 6137.754489820408, 6146.60047096939, 6149.569530132892, 6151.800398922212, 6220.253569571652, 5975.372585878475, 5985.25184351956, 6015.578909476339, 6078.422549857756, 6118.541109416789, 4767.284907263912, 4799.880002999918, 4802.5197480252045, 4816.349792777983, 4883.218685010399, 4724.952750472486, 4803.207470767319, 4830.565249127578, 4831.54100360467, 4835.927461088087, 4711.269753188244, 4795.136875362434, 4809.495003024685, 4854.0, 4855.150348688983, 4843.975780121094, 4845.030993801254, 4845.947053356398, 4851.417829860404, 4875.658703890729, 4349.108432771306, 4406.581374769392, 4421.027373977752, 4430.401895744066, 4446.244138496463, 6048.304444988838, 6067.726952287114, 6114.327423983358, 6122.540809439265, 6126.969365153146, 5771.711414429262, 5832.650040997553, 5847.26909136358, 5849.181114643953, 5851.473367396955, 6486.448651864597, 6489.513286503531, 6512.967435162794, 6602.2737498875085, 6643.93356066438, 4988.127077761377, 5006.674566153225, 5010.348654674905, 5054.898902021976, 5073.441921388644, 6827.21487028993, 6905.792826215222, 6915.239323674392, 6942.930570694279, 6946.3053694630635, 5105.642605017613, 5149.914284714697, 5155.123628983082, 5171.896562068813, 5180.430152683201, 5214.217867319857, 5218.921716174261, 5270.8155214567305, 5272.736363181825, 5291.576673866081, 5674.375818659944, 5739.799107031234, 5791.160281759206, 5797.304323481209, 5827.854303642443, 6344.936550634527, 6436.839079022968, 6451.677416129175, 6516.413522782972, 6557.868842623121, 1729.1699984007746, 1734.5056658852166, 1787.2484964734374, 1791.2118667786133, 1813.2565648084221, 1246.1214843535286, 1274.4756115788912, 1291.6770807298176, 1297.6042307096427, 1303.3222724183372, 6187.133801267736, 6329.461995730415, 6330.430261276507, 6367.61794292344, 6408.55140140195, 6752.392284694303, 6790.7623233186605, 6805.727770889208, 6806.489513286523, 6835.111435513351, 6329.430351268408, 6333.0, 6340.492760579143, 6357.300696923335, 6369.681515924185, 3514.1741690702665, 3536.717062634983, 3540.150363912642, 3557.0, 3583.5878873929832, 6845.212800528003, 6900.0679809653375, 6900.516963812485, 6948.722051117999, 6950.513464057467, 6792.660366981631, 6840.384365407137, 6861.451083913275, 6864.38220560152, 6884.586924784428, 6911.6544172791155, 6933.1333583302085, 6933.722651094001, 6993.160820701549, 7007.544509606859, 6702.994550817221, 6727.226368967631, 6772.424343930821, 6800.421964133104, 6830.795076147723, 6652.700628471827, 6658.267590565131, 6662.0, 6688.464922806261, 6728.529002969941, 6991.2309645937885, 7000.439964802906, 7003.649817509002, 7004.303343212798, 7017.508774385744, 5148.48119804666, 5168.224766285088, 5177.870553236048, 5194.948050519598, 5213.13983192769, 6471.870562588816, 6545.952647576365, 6713.429358504582, 6743.831404214934, 6750.6624668767345, 6271.937280627318, 6458.22501299847, 6511.47908167336, 6526.67366631676, 6541.182352205974, 6374.043893415839, 6524.739010439719, 6539.574927629689, 6548.508861835287, 6584.736610535525, 6470.6441145737435, 6520.282768895512, 6538.444232240313, 6554.442872355903, 6584.045313429621, 6554.639494827639, 6563.245226798979, 6565.901511477427, 6597.27429982692, 6614.735410583715, 6281.40326668984, 6330.366963303817, 6392.680365981775, 6403.839904002437, 6414.454771344302], "value": 5127.721680570858, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.1965658675006, 975.1175186456255, 1002.108123769845, 1010.2372708605002, 1016.146436992926, 17049.914750426247, 17250.82749172508, 17327.913360433195, 17399.217035233414, 17490.38783642573, 17537.73693394597, 20852.582948341023, 20947.685784713205, 21404.25085122021, 21485.0, 1066.7066556696911, 1079.703081652544, 1090.2913106480771, 1090.607381342716, 1090.8091084060259, 1090.547422819529, 1092.9617463388784, 1098.3739268616891, 1099.0987390339924, 1100.3562915694329, 1029.7271223125877, 1111.0, 1128.0355296221735, 1128.2440764687638, 1128.3399211461306, 1103.5309993252836, 1109.8224284114583, 1115.4367044642486, 1115.8493603363563, 1118.932864028161, 815.461795215161, 815.5514467043162, 817.9509229446252, 818.108261994429, 819.3240576524331, 18435.262589496404, 18567.535811604685, 18722.157502912403, 18751.343702970466, 19858.404247872586, 21086.683699744517, 21211.151553937823, 21410.250641227638, 21444.24945126913, 21768.89115554412, 16521.91739041309, 16673.333066677318, 16800.0, 16848.83151168485, 16922.069286189253, 3779.130799916007, 3810.123671555558, 3811.3520701480816, 3812.942805857914, 3814.771113733185, 140058.57273777676, 140105.59894401027, 141011.0, 141542.29228853894, 143329.0, 16474.58813529671, 16678.166091695366, 16734.330626775038, 16738.665226695397, 16884.915575422045, 32323.19192020218, 32619.184520386705, 33505.329893402, 33572.49641255383, 33619.495707564405, 8717.912820871838, 8722.563871806511, 8943.3739638226, 8967.775805604912, 8977.147171018743, 4422.668299877522, 4466.263066593976, 4497.752623605667, 4508.0, 4508.188526065274, 5804.1293805929445, 5839.211706419664, 5924.052151655801, 5953.285605727254, 5966.075258334965, 1219.4756254810516, 1233.463443402123, 1240.0389697984135, 1247.7504499100216, 1254.8556915954782, 735.1398863329916, 762.8931949527071, 766.4864540757594, 769.342212408394, 777.9766607001799, 12665.936670316589, 13450.327483625779, 13690.452381904612, 13720.65698357549, 13729.588112356645, 703.5928143712575, 706.7137809187287, 714.5998240985065, 730.8830587106144, 732.5641243460133, 6073.48375388097, 6167.96916015426, 6240.282367527792, 6257.812265631947, 6657.633830139389, 122347.3882630599, 128266.35866820606, 131525.0, 132181.33909330584, 138334.0, 113249.0, 115100.42449787697, 116122.0, 118359.40820295844, 122014.38992804979, 99357.0, 101203.49398252962, 101590.49204754077, 101931.49034254781, 104799.0, 13548.644736185373, 13616.795748063589, 13660.93169534146, 13731.656708582366, 13918.234497102352, 46622.53377466318, 46700.299495506915, 46890.53109468862, 47340.0, 47649.76175119102, 85894.85262868478, 87379.0, 88079.1192088071, 88509.55745221232, 91575.0, 20467.28364507235, 20634.484137896074, 21641.13435462564, 21701.891490542446, 22007.339779806633, 22320.553588928455, 22790.202342917917, 22851.31446056621, 22879.771202287764, 22924.19765308206, 20939.790602093784, 21437.0, 21455.356339309845, 21638.35084947454, 21670.783292166878, 21314.0, 21548.67676984878, 21595.892020539795, 21684.24105156312, 21812.781872181076, 19945.102470389156, 21564.568708626055, 21715.782842172008, 21723.34829955104, 21857.89071054698, 15017.17405542662, 15394.46119385861, 15660.451884183998, 16170.434034808724, 16230.51308460748, 14608.269586520419, 14752.69416943901, 15958.12230327343, 16241.269142888363, 16509.58726031859], "value": 10046.491787151424, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 98.0, 107.0, 106.0, 108.0, 107.0, 101.0, 106.0, 110.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 134.0, 170.0, 112.0, 146.0, 143.0, 114.0, 171.0, 115.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 164.0, 162.0, 161.0, 162.0, 160.0, 163.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 76.0, 183.0, 76.0, 74.0, 74.0, 74.0, 166.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 125.0, 78.0, 78.0, 77.0, 130.0, 79.0, 78.0, 129.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 117.0, 113.0, 117.0, 116.0, 114.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 149.0, 149.0, 148.0, 147.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 49.0, 45.0, 49.0, 50.0, 55.0, 45.0, 45.0, 46.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 80.0, 73.0, 73.0, 71.0, 78.0, 73.0, 73.0, 79.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 117.0, 119.0, 118.0, 119.0, 131.0, 118.0, 117.0, 156.0], "value": 122.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 161.0, 160.0, 162.0, 155.0, 158.0, 159.0, 162.0, 157.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 58.0, 57.0, 59.0, 57.0, 59.0, 62.0, 56.0], "value": 58.3, "unit": "score"}]}]} 18:58:49 INFO - Return code: 0 18:58:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:58:50 INFO - # TBPL SUCCESS # 18:58:50 INFO - Running post-action listener: _package_coverage_data 18:58:50 INFO - Running post-action listener: _resource_record_post_action 18:58:50 INFO - [mozharness: 2017-09-21 01:58:50.025596Z] Finished run-tests step (success) 18:58:50 INFO - Running post-run listener: _resource_record_post_run 18:58:50 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 499712; Write bytes: 292302848; Read time: 32; Write time: 203476 18:58:50 INFO - TinderboxPrint: CPU usage
13.0% 18:58:50 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 32 18:58:50 INFO - TinderboxPrint: I/O write bytes / time
292,302,848 / 203,476 18:58:50 INFO - TinderboxPrint: CPU idle
8,211.1 (87.0%) 18:58:50 INFO - TinderboxPrint: CPU user
1,182.1 (12.5%) 18:58:50 INFO - TinderboxPrint: Swap in / out
0 / 0 18:58:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13217792; Read time: 0; Write time: 1844 18:58:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:58:50 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 495616; Write bytes: 279085056; Read time: 20; Write time: 201632 18:58:50 INFO - Running post-run listener: _upload_blobber_files 18:58:50 INFO - Blob upload gear active. 18:58:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:58:50 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 18:58:50 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'] 18:58:50 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 18:58:51 INFO - (blobuploader) - INFO - Open directory for files ... 18:58:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:58:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:52 INFO - (blobuploader) - INFO - Done attempting. 18:58:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:58:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:58 INFO - (blobuploader) - INFO - Done attempting. 18:58:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:58:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:58:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:59 INFO - (blobuploader) - INFO - Done attempting. 18:58:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:58:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:59:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:59:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:59:00 INFO - (blobuploader) - INFO - Done attempting. 18:59:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:59:00 INFO - Return code: 0 18:59:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:59:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:59:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c68e1a0e21e3812159997fd43159f5bd5f869e4d9ca649bad364e8759c52b93aa2292172316f0246996ded16c5330503dc459d4b2bcfd098ef860374ecfafa55", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/703043445a0889f634c92c27942b941d841a3f47379899f887e8d6fd3b7ffe2d84f7d3ac3975533ba59d283467da385fddf6c91e2ee53d81b614a6fd22b14659", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/568bd1e2bc554cd74cc76316a5fa1899eb0b7893d54b2f1da72ad90dea00b7732ad8cfd295dedbee489d978a14a975071609af3c5e2e98e4c69475c2452d2baa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa846858a451dcfd71f0ded401b5f667ee400428a3891a35122d3240a24f0507889142a2fb4e7856ac19828b1aafed505d9bdee072cc796e3500ae23bab7af16"} 18:59:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:59:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:59:00 INFO - Contents: 18:59:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c68e1a0e21e3812159997fd43159f5bd5f869e4d9ca649bad364e8759c52b93aa2292172316f0246996ded16c5330503dc459d4b2bcfd098ef860374ecfafa55", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/703043445a0889f634c92c27942b941d841a3f47379899f887e8d6fd3b7ffe2d84f7d3ac3975533ba59d283467da385fddf6c91e2ee53d81b614a6fd22b14659", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/568bd1e2bc554cd74cc76316a5fa1899eb0b7893d54b2f1da72ad90dea00b7732ad8cfd295dedbee489d978a14a975071609af3c5e2e98e4c69475c2452d2baa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa846858a451dcfd71f0ded401b5f667ee400428a3891a35122d3240a24f0507889142a2fb4e7856ac19828b1aafed505d9bdee072cc796e3500ae23bab7af16"} 18:59:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:59:00 INFO - Copying logs to upload dir... 18:59:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:59:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.341436 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-20 18:59:00.877606) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 18:59:00.881144) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c68e1a0e21e3812159997fd43159f5bd5f869e4d9ca649bad364e8759c52b93aa2292172316f0246996ded16c5330503dc459d4b2bcfd098ef860374ecfafa55", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/703043445a0889f634c92c27942b941d841a3f47379899f887e8d6fd3b7ffe2d84f7d3ac3975533ba59d283467da385fddf6c91e2ee53d81b614a6fd22b14659", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/568bd1e2bc554cd74cc76316a5fa1899eb0b7893d54b2f1da72ad90dea00b7732ad8cfd295dedbee489d978a14a975071609af3c5e2e98e4c69475c2452d2baa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa846858a451dcfd71f0ded401b5f667ee400428a3891a35122d3240a24f0507889142a2fb4e7856ac19828b1aafed505d9bdee072cc796e3500ae23bab7af16"} build_url:https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/bY8Gk3bnSgOe36AYStGP1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c68e1a0e21e3812159997fd43159f5bd5f869e4d9ca649bad364e8759c52b93aa2292172316f0246996ded16c5330503dc459d4b2bcfd098ef860374ecfafa55", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/703043445a0889f634c92c27942b941d841a3f47379899f887e8d6fd3b7ffe2d84f7d3ac3975533ba59d283467da385fddf6c91e2ee53d81b614a6fd22b14659", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/568bd1e2bc554cd74cc76316a5fa1899eb0b7893d54b2f1da72ad90dea00b7732ad8cfd295dedbee489d978a14a975071609af3c5e2e98e4c69475c2452d2baa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa846858a451dcfd71f0ded401b5f667ee400428a3891a35122d3240a24f0507889142a2fb4e7856ac19828b1aafed505d9bdee072cc796e3500ae23bab7af16"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 18:59:00.908696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:59:00.909004) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1505957820.57849-1010140521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:59:00.991724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 18:59:00.992043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 18:59:00.992360) ========= ========= Total master_lag: 0.19 =========