builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1505268504.46 results: success (0) revision: 867b9e3b4f92445085c77cecf485f6a5568faeaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.462053) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.465597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.465902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.532424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.532694) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 19:08:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-09-12 19:08:24 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143469 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.711499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.711774) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016386 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.765629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:24.765995) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 867b9e3b4f92445085c77cecf485f6a5568faeaf --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 867b9e3b4f92445085c77cecf485f6a5568faeaf --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=56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 19:08:24,980 truncating revision to first 12 chars 2017-09-12 19:08:24,980 Setting DEBUG logging. 2017-09-12 19:08:24,980 attempt 1/10 2017-09-12 19:08:24,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/867b9e3b4f92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 19:08:25,354 unpacking tar archive at: mozilla-beta-867b9e3b4f92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:25.419286) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:25.422614) ========= script_repo_revision: 867b9e3b4f92445085c77cecf485f6a5568faeaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:25.423006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:25.423300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 19:08:25.436530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-12 19:08:25.436818) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:25 INFO - MultiFileLogger online at 20170912 19:08:25 in /builds/slave/test 19:08:25 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 19:08:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:25 INFO - {'append_to_log': False, 19:08:25 INFO - 'base_work_dir': '/builds/slave/test', 19:08:25 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 19:08:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:25 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 19:08:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:25 INFO - 'code_coverage': False, 19:08:25 INFO - 'config_files': ('talos/linux_config.py',), 19:08:25 INFO - 'default_actions': ('clobber', 19:08:25 INFO - 'read-buildbot-config', 19:08:25 INFO - 'download-and-extract', 19:08:25 INFO - 'populate-webroot', 19:08:25 INFO - 'create-virtualenv', 19:08:25 INFO - 'install', 19:08:25 INFO - 'setup-mitmproxy', 19:08:25 INFO - 'run-tests'), 19:08:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:25 INFO - 'disable_ccov_upload': False, 19:08:25 INFO - 'download_minidump_stackwalk': True, 19:08:25 INFO - 'download_symbols': 'ondemand', 19:08:25 INFO - 'enable_stylo': False, 19:08:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:25 INFO - 'gecko_profile': False, 19:08:25 INFO - 'gecko_profile_interval': 0, 19:08:25 INFO - 'installer_path': 'installer.exe', 19:08:25 INFO - 'log_level': 'info', 19:08:25 INFO - 'log_name': 'talos', 19:08:25 INFO - 'log_to_console': True, 19:08:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:25 INFO - 'opt_config_files': (), 19:08:25 INFO - 'pip_index': False, 19:08:25 INFO - 'suite': 'dromaeojs-e10s', 19:08:25 INFO - 'system_bits': '32', 19:08:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:25 INFO - 'title': 'talos-linux64-ix-037', 19:08:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:25 INFO - 'use_talos_json': True, 19:08:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:25 INFO - 'work_dir': 'build'} 19:08:25 INFO - [mozharness: 2017-09-13 02:08:25.828783Z] Running clobber step. 19:08:25 INFO - Running pre-action listener: _resource_record_pre_action 19:08:25 INFO - Running main action method: clobber 19:08:25 INFO - rmtree: /builds/slave/test/build 19:08:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:26 INFO - Running post-action listener: _resource_record_post_action 19:08:26 INFO - [mozharness: 2017-09-13 02:08:26.815796Z] Finished clobber step (success) 19:08:26 INFO - [mozharness: 2017-09-13 02:08:26.815898Z] Running read-buildbot-config step. 19:08:26 INFO - Running pre-action listener: _resource_record_pre_action 19:08:26 INFO - Running main action method: read_buildbot_config 19:08:26 INFO - Using buildbot properties: 19:08:26 INFO - { 19:08:26 INFO - "project": "", 19:08:26 INFO - "product": "firefox", 19:08:26 INFO - "who": "ryanvm@gmail.com", 19:08:26 INFO - "installer_path": "public/build/target.tar.bz2", 19:08:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:08:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 19:08:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 19:08:26 INFO - "stage_platform": "linux64", 19:08:26 INFO - "basedir": "/builds/slave/test", 19:08:26 INFO - "buildnumber": 77, 19:08:26 INFO - "platform": "ubuntu64_hw", 19:08:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:08:26 INFO - "slavebuilddir": "test", 19:08:26 INFO - "taskId": "RIYpqDVbSzeixxKvHd99iQ", 19:08:26 INFO - "branch": "mozilla-beta", 19:08:26 INFO - "script_repo_revision": "production", 19:08:26 INFO - "revision": "867b9e3b4f92445085c77cecf485f6a5568faeaf", 19:08:26 INFO - "slavename": "talos-linux64-ix-037", 19:08:26 INFO - "repo_path": "releases/mozilla-beta" 19:08:26 INFO - } 19:08:26 INFO - Finding installer, test and symbols from parent task. 19:08:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RIYpqDVbSzeixxKvHd99iQ'}, attempt #1 19:08:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RIYpqDVbSzeixxKvHd99iQ'}, attempt #1 19:08:27 INFO - Task dependencies: cT48ck20TeqGgnCaSlrHrQ 19:08:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ'}, attempt #1 19:08:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2 19:08:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.test_packages.json 19:08:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.crashreporter-symbols.zip 19:08:28 INFO - Running post-action listener: _resource_record_post_action 19:08:28 INFO - [mozharness: 2017-09-13 02:08:28.170529Z] Finished read-buildbot-config step (success) 19:08:28 INFO - [mozharness: 2017-09-13 02:08:28.170749Z] Running download-and-extract step. 19:08:28 INFO - Running pre-action listener: _resource_record_pre_action 19:08:28 INFO - Running main action method: download_and_extract 19:08:28 INFO - mkdir: /builds/slave/test/build/tests 19:08:28 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')]} 19:08:28 INFO - trying https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.test_packages.json 19:08:28 INFO - Downloading https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:08:28 INFO - Downloaded 989 bytes. 19:08:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:08:28 INFO - Using the following test package requirements: 19:08:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:08:28 INFO - u'common': [u'target.common.tests.zip'], 19:08:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:08:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:08:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:08:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:08:28 INFO - u'mozbase': [u'target.common.tests.zip'], 19:08:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:08:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:08:28 INFO - u'web-platform': [u'target.common.tests.zip', 19:08:28 INFO - u'target.web-platform.tests.tar.gz'], 19:08:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:08:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 19:08:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.common.tests.zip 19:08:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:08:28 INFO - Fetch https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.common.tests.zip into memory 19:08:31 INFO - Content-Length response header: 72857624 19:08:31 INFO - Bytes received: 72857624 19:08:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.talos.tests.zip 19:08:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:08:42 INFO - Fetch https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.talos.tests.zip into memory 19:08:43 INFO - Content-Length response header: 14496472 19:08:43 INFO - Bytes received: 14496472 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:43 INFO - trying https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2 19:08:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:08:45 INFO - Downloaded 54069555 bytes. 19:08:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2 19:08:46 INFO - mkdir: /builds/slave/test/properties 19:08:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:46 INFO - Contents: 19:08:46 INFO - build_url:https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2 19:08:46 INFO - Running post-action listener: _resource_record_post_action 19:08:46 INFO - Running post-action listener: set_extra_try_arguments 19:08:46 INFO - [mozharness: 2017-09-13 02:08:46.337971Z] Finished download-and-extract step (success) 19:08:46 INFO - [mozharness: 2017-09-13 02:08:46.338071Z] Running populate-webroot step. 19:08:46 INFO - Running pre-action listener: _resource_record_pre_action 19:08:46 INFO - Running main action method: populate_webroot 19:08:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:08:46 INFO - 'tests': ['damp', 'tps']}, 19:08:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:08:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:08:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:08:46 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:46 INFO - 'ts_paint', 19:08:46 INFO - 'tpaint', 19:08:46 INFO - 'sessionrestore', 19:08:46 INFO - 'sessionrestore_many_windows', 19:08:46 INFO - 'sessionrestore_no_auto_restore', 19:08:46 INFO - 'tabpaint']}, 19:08:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:08:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:08:46 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:08:46 INFO - 'talos_options': ['--mitmproxy', 19:08:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:08:46 INFO - '--firstNonBlankPaint'], 19:08:46 INFO - 'tests': ['quantum_pageload_google', 19:08:46 INFO - 'quantum_pageload_youtube', 19:08:46 INFO - 'quantum_pageload_amazon', 19:08:46 INFO - 'quantum_pageload_facebook']}, 19:08:46 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:08:46 INFO - 'talos_options': ['--stylo', 19:08:46 INFO - '--mitmproxy', 19:08:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:08:46 INFO - '--firstNonBlankPaint'], 19:08:46 INFO - 'tests': ['quantum_pageload_google', 19:08:46 INFO - 'quantum_pageload_youtube', 19:08:46 INFO - 'quantum_pageload_amazon', 19:08:46 INFO - 'quantum_pageload_facebook']}, 19:08:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:46 INFO - 'tsvgr_opacity', 19:08:46 INFO - 'tart', 19:08:46 INFO - 'tscrollx', 19:08:46 INFO - 'cart', 19:08:46 INFO - 'tsvg_static']}, 19:08:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:08:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:08:46 INFO - 'talos_options': ['--stylo', 19:08:46 INFO - '--stylo-threads=1', 19:08:46 INFO - '--mitmproxy', 19:08:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:08:46 INFO - '--firstNonBlankPaint'], 19:08:46 INFO - 'tests': ['tp6_google', 19:08:46 INFO - 'tp6_youtube', 19:08:46 INFO - 'tp6_amazon', 19:08:46 INFO - 'tp6_facebook']}, 19:08:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:08:46 INFO - 'talos_options': ['--xperf_path', 19:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:46 INFO - 'tests': ['tp5n']}}} 19:08:46 INFO - Running post-action listener: _resource_record_post_action 19:08:46 INFO - [mozharness: 2017-09-13 02:08:46.346705Z] Finished populate-webroot step (success) 19:08:46 INFO - [mozharness: 2017-09-13 02:08:46.346794Z] Running create-virtualenv step. 19:08:46 INFO - Running pre-action listener: _resource_record_pre_action 19:08:46 INFO - Running main action method: create_virtualenv 19:08:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:46 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 19:08:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:08:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:46 INFO - Using real prefix '/usr' 19:08:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:49 INFO - Installing pip.................done. 19:08:49 INFO - Return code: 0 19:08:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:08:49 INFO - Reading from file tmpfile_stdout 19:08:49 INFO - Output received: 19:08:49 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) 19:08:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:49 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')]} 19:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:49 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')]} 19:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:49 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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08:49 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 19:08:49 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 19:08:49 INFO - Using env: {'DISPLAY': ':0', 19:08:49 INFO - 'HOME': '/home/cltbld', 19:08:49 INFO - 'LANG': 'en_US.UTF-8', 19:08:49 INFO - 'LANGUAGE': 'en_US:en', 19:08:49 INFO - 'LOGNAME': 'cltbld', 19:08:49 INFO - 'MAIL': '/var/mail/cltbld', 19:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:49 INFO - 'MOZ_NO_REMOTE': '1', 19:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:49 INFO - 'NO_EM_RESTART': '1', 19:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:49 INFO - 'PWD': '/builds/slave/test', 19:08:49 INFO - 'SHELL': '/bin/bash', 19:08:49 INFO - 'SHLVL': '1', 19:08:49 INFO - 'TERM': 'linux', 19:08:49 INFO - 'TMOUT': '86400', 19:08:49 INFO - 'USER': 'cltbld', 19:08:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:49 INFO - '_': '/tools/buildbot/bin/python'} 19:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:49 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 19:08:49 INFO - Cleaning up... 19:08:50 INFO - Return code: 0 19:08:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:50 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')]} 19:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:50 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')]} 19:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:50 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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08:50 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 19:08:50 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 19:08:50 INFO - Using env: {'DISPLAY': ':0', 19:08:50 INFO - 'HOME': '/home/cltbld', 19:08:50 INFO - 'LANG': 'en_US.UTF-8', 19:08:50 INFO - 'LANGUAGE': 'en_US:en', 19:08:50 INFO - 'LOGNAME': 'cltbld', 19:08:50 INFO - 'MAIL': '/var/mail/cltbld', 19:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:50 INFO - 'MOZ_NO_REMOTE': '1', 19:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:50 INFO - 'NO_EM_RESTART': '1', 19:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:50 INFO - 'PWD': '/builds/slave/test', 19:08:50 INFO - 'SHELL': '/bin/bash', 19:08:50 INFO - 'SHLVL': '1', 19:08:50 INFO - 'TERM': 'linux', 19:08:50 INFO - 'TMOUT': '86400', 19:08:50 INFO - 'USER': 'cltbld', 19:08:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:50 INFO - '_': '/tools/buildbot/bin/python'} 19:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:50 INFO - Downloading/unpacking psutil>=3.1.1 19:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:51 INFO - Installing collected packages: psutil 19:08:51 INFO - Running setup.py install for psutil 19:08:51 INFO - building 'psutil._psutil_linux' extension 19:08:51 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 19:08:52 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 19:08:53 INFO - building 'psutil._psutil_posix' extension 19:08:53 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 19:08:53 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 19:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:53 INFO - Successfully installed psutil 19:08:53 INFO - Cleaning up... 19:08:53 INFO - Return code: 0 19:08:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08: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')]} 19:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:08: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 mozsystemmonitor==0.3 19:08:53 INFO - Using env: {'DISPLAY': ':0', 19:08:53 INFO - 'HOME': '/home/cltbld', 19:08:53 INFO - 'LANG': 'en_US.UTF-8', 19:08:53 INFO - 'LANGUAGE': 'en_US:en', 19:08:53 INFO - 'LOGNAME': 'cltbld', 19:08:53 INFO - 'MAIL': '/var/mail/cltbld', 19:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:53 INFO - 'MOZ_NO_REMOTE': '1', 19:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:53 INFO - 'NO_EM_RESTART': '1', 19:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:53 INFO - 'PWD': '/builds/slave/test', 19:08:53 INFO - 'SHELL': '/bin/bash', 19:08:53 INFO - 'SHLVL': '1', 19:08:53 INFO - 'TERM': 'linux', 19:08:53 INFO - 'TMOUT': '86400', 19:08:53 INFO - 'USER': 'cltbld', 19:08:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:53 INFO - '_': '/tools/buildbot/bin/python'} 19:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08: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 19:08: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 19:08: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 19:08: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 19:08:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:54 INFO - Installing collected packages: mozsystemmonitor 19:08:54 INFO - Running setup.py install for mozsystemmonitor 19:08:54 INFO - Successfully installed mozsystemmonitor 19:08:54 INFO - Cleaning up... 19:08:54 INFO - Return code: 0 19:08:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08: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')]} 19:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08: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', '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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:08: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 jsonschema==2.5.1 19:08:54 INFO - Using env: {'DISPLAY': ':0', 19:08:54 INFO - 'HOME': '/home/cltbld', 19:08:54 INFO - 'LANG': 'en_US.UTF-8', 19:08:54 INFO - 'LANGUAGE': 'en_US:en', 19:08:54 INFO - 'LOGNAME': 'cltbld', 19:08:54 INFO - 'MAIL': '/var/mail/cltbld', 19:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:54 INFO - 'MOZ_NO_REMOTE': '1', 19:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:54 INFO - 'NO_EM_RESTART': '1', 19:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:54 INFO - 'PWD': '/builds/slave/test', 19:08:54 INFO - 'SHELL': '/bin/bash', 19:08:54 INFO - 'SHLVL': '1', 19:08:54 INFO - 'TERM': 'linux', 19:08:54 INFO - 'TMOUT': '86400', 19:08:54 INFO - 'USER': 'cltbld', 19:08:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:54 INFO - '_': '/tools/buildbot/bin/python'} 19:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:55 INFO - Downloading/unpacking jsonschema==2.5.1 19:08: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 19:08: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 19:08: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 19:08: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 19:08:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:56 INFO - warning: no files found matching '*.txt' 19:08:56 INFO - no previously-included directories found matching 'build' 19:08:56 INFO - no previously-included directories found matching 'dist' 19:08:56 INFO - no previously-included directories found matching '.git*' 19:08:56 INFO - Installing collected packages: jsonschema, functools32 19:08:56 INFO - Running setup.py install for functools32 19:08:56 INFO - warning: no files found matching '*.txt' 19:08:56 INFO - no previously-included directories found matching 'build' 19:08:56 INFO - no previously-included directories found matching 'dist' 19:08:56 INFO - no previously-included directories found matching '.git*' 19:08:56 INFO - Successfully installed jsonschema functools32 19:08:56 INFO - Cleaning up... 19:08:56 INFO - Return code: 0 19:08:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:08:56 INFO - Using env: {'DISPLAY': ':0', 19:08:56 INFO - 'HOME': '/home/cltbld', 19:08:56 INFO - 'LANG': 'en_US.UTF-8', 19:08:56 INFO - 'LANGUAGE': 'en_US:en', 19:08:56 INFO - 'LOGNAME': 'cltbld', 19:08:56 INFO - 'MAIL': '/var/mail/cltbld', 19:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:56 INFO - 'MOZ_NO_REMOTE': '1', 19:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:56 INFO - 'NO_EM_RESTART': '1', 19:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:56 INFO - 'PWD': '/builds/slave/test', 19:08:56 INFO - 'SHELL': '/bin/bash', 19:08:56 INFO - 'SHLVL': '1', 19:08:56 INFO - 'TERM': 'linux', 19:08:56 INFO - 'TMOUT': '86400', 19:08:56 INFO - 'USER': 'cltbld', 19:08:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:56 INFO - '_': '/tools/buildbot/bin/python'} 19:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:08:56 INFO - Cleaning up... 19:08:56 INFO - Return code: 0 19:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:08:56 INFO - Using env: {'DISPLAY': ':0', 19:08:56 INFO - 'HOME': '/home/cltbld', 19:08:56 INFO - 'LANG': 'en_US.UTF-8', 19:08:56 INFO - 'LANGUAGE': 'en_US:en', 19:08:56 INFO - 'LOGNAME': 'cltbld', 19:08:56 INFO - 'MAIL': '/var/mail/cltbld', 19:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:56 INFO - 'MOZ_NO_REMOTE': '1', 19:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:56 INFO - 'NO_EM_RESTART': '1', 19:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:56 INFO - 'PWD': '/builds/slave/test', 19:08:56 INFO - 'SHELL': '/bin/bash', 19:08:56 INFO - 'SHLVL': '1', 19:08:56 INFO - 'TERM': 'linux', 19:08:56 INFO - 'TMOUT': '86400', 19:08:56 INFO - 'USER': 'cltbld', 19:08:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:56 INFO - '_': '/tools/buildbot/bin/python'} 19:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:58 INFO - Downloading docopt-0.6.1.tar.gz 19:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:58 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:58 INFO - Running setup.py install for blobuploader 19:08:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:58 INFO - Running setup.py install for requests 19:08:59 INFO - Running setup.py install for docopt 19:08:59 INFO - Successfully installed blobuploader requests docopt 19:08:59 INFO - Cleaning up... 19:08:59 INFO - Return code: 0 19:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08: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')]} 19:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:59 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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:08:59 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 19:08:59 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 19:08:59 INFO - Using env: {'DISPLAY': ':0', 19:08:59 INFO - 'HOME': '/home/cltbld', 19:08:59 INFO - 'LANG': 'en_US.UTF-8', 19:08:59 INFO - 'LANGUAGE': 'en_US:en', 19:08:59 INFO - 'LOGNAME': 'cltbld', 19:08:59 INFO - 'MAIL': '/var/mail/cltbld', 19:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:59 INFO - 'MOZ_NO_REMOTE': '1', 19:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:59 INFO - 'NO_EM_RESTART': '1', 19:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:59 INFO - 'PWD': '/builds/slave/test', 19:08:59 INFO - 'SHELL': '/bin/bash', 19:08:59 INFO - 'SHLVL': '1', 19:08:59 INFO - 'TERM': 'linux', 19:08:59 INFO - 'TMOUT': '86400', 19:08:59 INFO - 'USER': 'cltbld', 19:08:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:59 INFO - '_': '/tools/buildbot/bin/python'} 19:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:59 INFO - Running setup.py (path:/tmp/pip-lKfYFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:59 INFO - Running setup.py (path:/tmp/pip-1zWduk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:59 INFO - Running setup.py (path:/tmp/pip-bQfx1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:59 INFO - Running setup.py (path:/tmp/pip-dJN1mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:59 INFO - Running setup.py (path:/tmp/pip-u38JuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:59 INFO - Running setup.py (path:/tmp/pip-CJwGi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:59 INFO - Running setup.py (path:/tmp/pip-q7AVc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:59 INFO - Running setup.py (path:/tmp/pip-1AXDIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:00 INFO - Running setup.py (path:/tmp/pip-Eq_1Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:00 INFO - Running setup.py (path:/tmp/pip-sVRq6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:00 INFO - Running setup.py (path:/tmp/pip-o8sOY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:00 INFO - Running setup.py (path:/tmp/pip-Shd2kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:00 INFO - Running setup.py (path:/tmp/pip-RhLkCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:00 INFO - Running setup.py (path:/tmp/pip-8L8UuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:00 INFO - Running setup.py (path:/tmp/pip-TUTM4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:00 INFO - Running setup.py (path:/tmp/pip-zCR4pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:00 INFO - Running setup.py (path:/tmp/pip-s9Mzee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:00 INFO - Running setup.py install for manifestparser 19:09:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:00 INFO - Running setup.py install for mozcrash 19:09:00 INFO - Running setup.py install for mozdebug 19:09:01 INFO - Running setup.py install for mozdevice 19:09:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Running setup.py install for mozfile 19:09:01 INFO - Running setup.py install for mozhttpd 19:09:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Running setup.py install for mozinfo 19:09:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Running setup.py install for mozInstall 19:09:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Running setup.py install for mozleak 19:09:01 INFO - Running setup.py install for mozlog 19:09:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Running setup.py install for moznetwork 19:09:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:01 INFO - Running setup.py install for mozprocess 19:09:01 INFO - Running setup.py install for mozprofile 19:09:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:02 INFO - Running setup.py install for mozrunner 19:09:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:02 INFO - Running setup.py install for mozscreenshot 19:09:02 INFO - Running setup.py install for moztest 19:09:02 INFO - Running setup.py install for mozversion 19:09:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:02 INFO - Cleaning up... 19:09:02 INFO - Return code: 0 19:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:02 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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:09:02 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 19:09:02 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 19:09:02 INFO - Using env: {'DISPLAY': ':0', 19:09:02 INFO - 'HOME': '/home/cltbld', 19:09:02 INFO - 'LANG': 'en_US.UTF-8', 19:09:02 INFO - 'LANGUAGE': 'en_US:en', 19:09:02 INFO - 'LOGNAME': 'cltbld', 19:09:02 INFO - 'MAIL': '/var/mail/cltbld', 19:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:02 INFO - 'MOZ_NO_REMOTE': '1', 19:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:02 INFO - 'NO_EM_RESTART': '1', 19:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:02 INFO - 'PWD': '/builds/slave/test', 19:09:02 INFO - 'SHELL': '/bin/bash', 19:09:02 INFO - 'SHLVL': '1', 19:09:02 INFO - 'TERM': 'linux', 19:09:02 INFO - 'TMOUT': '86400', 19:09:02 INFO - 'USER': 'cltbld', 19:09:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:02 INFO - '_': '/tools/buildbot/bin/python'} 19:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:02 INFO - Running setup.py (path:/tmp/pip-8mG3vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:02 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)) 19:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:02 INFO - Running setup.py (path:/tmp/pip-aTeVfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:02 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)) 19:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:02 INFO - Running setup.py (path:/tmp/pip-jrSSkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:02 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)) 19:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:02 INFO - Running setup.py (path:/tmp/pip-hur5mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:03 INFO - Running setup.py (path:/tmp/pip-qeYfWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:03 INFO - Running setup.py (path:/tmp/pip-I1qclp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:03 INFO - Running setup.py (path:/tmp/pip-Y48OKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:03 INFO - Running setup.py (path:/tmp/pip-tjmTv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:03 INFO - Running setup.py (path:/tmp/pip-SuS1fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:03 INFO - Running setup.py (path:/tmp/pip-6T893c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:03 INFO - Running setup.py (path:/tmp/pip-zYM3am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:03 INFO - Running setup.py (path:/tmp/pip-YO4vjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:03 INFO - Running setup.py (path:/tmp/pip-9oy2y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:03 INFO - Running setup.py (path:/tmp/pip-oJY5QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:03 INFO - Running setup.py (path:/tmp/pip-v0Loos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:03 INFO - Running setup.py (path:/tmp/pip-KathSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:03 INFO - Running setup.py (path:/tmp/pip-DBTYYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:03 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)) 19:09:03 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)) 19:09:03 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)) 19:09:03 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)) 19:09:03 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)) 19:09:03 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)) 19:09:03 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)) 19:09:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:05 INFO - Downloading blessings-1.6.tar.gz 19:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:05 INFO - Installing collected packages: blessings 19:09:05 INFO - Running setup.py install for blessings 19:09:05 INFO - Successfully installed blessings 19:09:05 INFO - Cleaning up... 19:09:05 INFO - Return code: 0 19:09:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:05 INFO - Reading from file tmpfile_stdout 19:09:05 INFO - Current package versions: 19:09:05 INFO - argparse == 1.2.1 19:09:05 INFO - blessings == 1.6 19:09:05 INFO - blobuploader == 1.2.4 19:09:05 INFO - docopt == 0.6.1 19:09:05 INFO - functools32 == 3.2.3-2 19:09:05 INFO - jsonschema == 2.5.1 19:09:05 INFO - manifestparser == 1.1 19:09:05 INFO - mozInstall == 1.13 19:09:05 INFO - mozcrash == 1.0 19:09:05 INFO - mozdebug == 0.1 19:09:05 INFO - mozdevice == 0.51 19:09:05 INFO - mozfile == 1.2 19:09:05 INFO - mozhttpd == 0.7 19:09:05 INFO - mozinfo == 0.10 19:09:05 INFO - mozleak == 0.1 19:09:05 INFO - mozlog == 3.5 19:09:05 INFO - moznetwork == 0.27 19:09:05 INFO - mozprocess == 0.25 19:09:05 INFO - mozprofile == 0.28 19:09:05 INFO - mozrunner == 6.13 19:09:05 INFO - mozscreenshot == 0.1 19:09:05 INFO - mozsystemmonitor == 0.3 19:09:05 INFO - moztest == 0.8 19:09:05 INFO - mozversion == 1.4 19:09:05 INFO - psutil == 3.1.1 19:09:05 INFO - requests == 1.2.3 19:09:05 INFO - wsgiref == 0.1.2 19:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:05 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 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:09:05 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 19:09:05 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 19:09:05 INFO - Using env: {'DISPLAY': ':0', 19:09:05 INFO - 'HOME': '/home/cltbld', 19:09:05 INFO - 'LANG': 'en_US.UTF-8', 19:09:05 INFO - 'LANGUAGE': 'en_US:en', 19:09:05 INFO - 'LOGNAME': 'cltbld', 19:09:05 INFO - 'MAIL': '/var/mail/cltbld', 19:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:05 INFO - 'MOZ_NO_REMOTE': '1', 19:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:05 INFO - 'NO_EM_RESTART': '1', 19:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:05 INFO - 'PWD': '/builds/slave/test', 19:09:05 INFO - 'SHELL': '/bin/bash', 19:09:05 INFO - 'SHLVL': '1', 19:09:05 INFO - 'TERM': 'linux', 19:09:05 INFO - 'TMOUT': '86400', 19:09:05 INFO - 'USER': 'cltbld', 19:09:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:05 INFO - '_': '/tools/buildbot/bin/python'} 19:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:09:06 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)) 19:09:06 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)) 19:09:06 INFO - Installing collected packages: simplejson 19:09:06 INFO - Running setup.py install for simplejson 19:09:06 INFO - building 'simplejson._speedups' extension 19:09:06 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 19:09:07 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 19:09:07 INFO - Successfully installed simplejson 19:09:07 INFO - Cleaning up... 19:09:07 INFO - Return code: 0 19:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f41eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', '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 19:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:09:07 INFO - Using env: {'DISPLAY': ':0', 19:09:07 INFO - 'HOME': '/home/cltbld', 19:09:07 INFO - 'LANG': 'en_US.UTF-8', 19:09:07 INFO - 'LANGUAGE': 'en_US:en', 19:09:07 INFO - 'LOGNAME': 'cltbld', 19:09:07 INFO - 'MAIL': '/var/mail/cltbld', 19:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:07 INFO - 'MOZ_NO_REMOTE': '1', 19:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:07 INFO - 'NO_EM_RESTART': '1', 19:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:07 INFO - 'PWD': '/builds/slave/test', 19:09:07 INFO - 'SHELL': '/bin/bash', 19:09:07 INFO - 'SHLVL': '1', 19:09:07 INFO - 'TERM': 'linux', 19:09:07 INFO - 'TMOUT': '86400', 19:09:07 INFO - 'USER': 'cltbld', 19:09:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:07 INFO - '_': '/tools/buildbot/bin/python'} 19:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:09:08 INFO - Cleaning up... 19:09:08 INFO - Return code: 0 19:09:08 INFO - Running post-action listener: _resource_record_post_action 19:09:08 INFO - Running post-action listener: _start_resource_monitoring 19:09:08 INFO - Starting resource monitoring. 19:09:08 INFO - [mozharness: 2017-09-13 02:09:08.252516Z] Finished create-virtualenv step (success) 19:09:08 INFO - [mozharness: 2017-09-13 02:09:08.253625Z] Running install step. 19:09:08 INFO - Running pre-action listener: _resource_record_pre_action 19:09:08 INFO - Running main action method: install 19:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:08 INFO - Reading from file tmpfile_stdout 19:09:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:08 INFO - Reading from file tmpfile_stdout 19:09:08 INFO - Output received: 19:09:08 INFO - Usage: mozinstall [options] installer 19:09:08 INFO - Options: 19:09:08 INFO - -h, --help show this help message and exit 19:09:08 INFO - -d DEST, --destination=DEST 19:09:08 INFO - Directory to install application into. [default: 19:09:08 INFO - "/builds/slave/test"] 19:09:08 INFO - --app=APP Application being installed. [default: firefox] 19:09:08 INFO - mkdir: /builds/slave/test/build/application 19:09:08 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'] 19:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:09:23 INFO - Reading from file tmpfile_stdout 19:09:23 INFO - Output received: 19:09:23 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:23 INFO - Running post-action listener: _resource_record_post_action 19:09:23 INFO - [mozharness: 2017-09-13 02:09:23.364128Z] Finished install step (success) 19:09:23 INFO - [mozharness: 2017-09-13 02:09:23.364397Z] Running setup-mitmproxy step. 19:09:23 INFO - Running pre-action listener: _resource_record_pre_action 19:09:23 INFO - Running main action method: setup_mitmproxy 19:09:23 INFO - Skipping: mitmproxy is not required 19:09:23 INFO - Running post-action listener: _resource_record_post_action 19:09:23 INFO - [mozharness: 2017-09-13 02:09:23.365584Z] Finished setup-mitmproxy step (success) 19:09:23 INFO - [mozharness: 2017-09-13 02:09:23.365805Z] Running run-tests step. 19:09:23 INFO - Running pre-action listener: _resource_record_pre_action 19:09:23 INFO - Running pre-action listener: _set_gcov_prefix 19:09:23 INFO - Running main action method: run_tests 19:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:23 INFO - Python 2.7.3 19:09:23 INFO - Return code: 0 19:09:23 INFO - grabbing minidump binary from tooltool 19:09:23 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')]} 19:09:23 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 0x1f3f050>, '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 0x1f3ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f403e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:23 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 19:09:23 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 19:09:23 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 19:09:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:23 INFO - Return code: 0 19:09:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:23 INFO - ENV: RUST_BACKTRACE is now 1 19:09:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:23 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/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 19:09:23 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/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 19:09:23 INFO - Using env: {'DISPLAY': ':0', 19:09:23 INFO - 'HOME': '/home/cltbld', 19:09:23 INFO - 'LANG': 'en_US.UTF-8', 19:09:23 INFO - 'LANGUAGE': 'en_US:en', 19:09:23 INFO - 'LOGNAME': 'cltbld', 19:09:23 INFO - 'MAIL': '/var/mail/cltbld', 19:09:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:23 INFO - 'MOZ_NO_REMOTE': '1', 19:09:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:23 INFO - 'NO_EM_RESTART': '1', 19:09:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:23 INFO - 'PWD': '/builds/slave/test', 19:09:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:23 INFO - 'RUST_BACKTRACE': '1', 19:09:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:09:23 INFO - 'SHELL': '/bin/bash', 19:09:23 INFO - 'SHLVL': '1', 19:09:23 INFO - 'TERM': 'linux', 19:09:23 INFO - 'TMOUT': '86400', 19:09:23 INFO - 'USER': 'cltbld', 19:09:23 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051', 19:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:23 INFO - '_': '/tools/buildbot/bin/python'} 19:09:23 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/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 19:09:23 INFO - mozversion application_buildid: 20170913005904 19:09:23 INFO - mozversion application_changeset: 867b9e3b4f92445085c77cecf485f6a5568faeaf 19:09:23 INFO - mozversion application_display_name: Firefox 19:09:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:23 INFO - mozversion application_name: Firefox 19:09:23 INFO - mozversion application_remotingname: firefox 19:09:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:09:23 INFO - mozversion application_vendor: Mozilla 19:09:23 INFO - mozversion application_version: 56.0 19:09:23 INFO - mozversion platform_buildid: 20170913005904 19:09:23 INFO - mozversion platform_changeset: 867b9e3b4f92445085c77cecf485f6a5568faeaf 19:09:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:09:23 INFO - mozversion platform_version: 56.0 19:09:23 INFO - using testdate: 1505268563 19:09:23 INFO - actual date: 1505268563 19:09:23 INFO - starting webserver on 'localhost:59910' 19:09:23 INFO - SUITE-START | Running 2 tests 19:09:23 INFO - TEST-START | dromaeo_css 19:09:23 INFO - Initialising browser for dromaeo_css test... 19:09:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59910/getInfo.html -profile /tmp/tmpxdxTM3/profile 19:09:23 INFO - TEST-INFO | started process 3563 (/builds/slave/test/build/application/firefox/firefox http://localhost:59910/getInfo.html) 19:09:32 INFO - TEST-INFO | 3563: exit 0 19:09:32 INFO - Browser initialized. 19:09:32 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:32 INFO - TEST-INFO | started process 3727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxdxTM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:44 INFO - PID 3727 | RSS: Main: 151638016 19:09:44 INFO - PID 3727 | 19:12:41 INFO - PID 3727 | Cycle 1(1): loaded http://localhost:59910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59910/tests/dromaeo/cssquery-ext.html) 19:12:42 INFO - PID 3727 | RSS: Main: 159301632 19:12:42 INFO - PID 3727 | 19:15:44 INFO - PID 3727 | Cycle 1(1): loaded http://localhost:59910/tests/dromaeo/cssquery-ext.html (next: http://localhost:59910/tests/dromaeo/cssquery-jquery.html) 19:15:44 INFO - PID 3727 | RSS: Main: 157945856 19:15:44 INFO - PID 3727 | 19:18:46 INFO - PID 3727 | Cycle 1(1): loaded http://localhost:59910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59910/tests/dromaeo/cssquery-mootools.html) 19:18:46 INFO - PID 3727 | RSS: Main: 159428608 19:18:46 INFO - PID 3727 | 19:21:48 INFO - PID 3727 | Cycle 1(1): loaded http://localhost:59910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59910/tests/dromaeo/cssquery-prototype.html) 19:21:49 INFO - PID 3727 | RSS: Main: 159174656 19:21:49 INFO - PID 3727 | 19:24:52 INFO - PID 3727 | Cycle 1(1): loaded http://localhost:59910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59910/tests/dromaeo/cssquery-yui.html) 19:24:52 INFO - PID 3727 | RSS: Main: 162095104 19:24:52 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | Cycle 1(1): loaded http://localhost:59910/tests/dromaeo/cssquery-yui.html (next: http://localhost:59910/tests/dromaeo/cssquery-dojo.html) 19:27:54 INFO - PID 3727 | RSS: Main: 164773888 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | __start_tp_report 19:27:54 INFO - PID 3727 | _x_x_mozilla_page_load 19:27:54 INFO - PID 3727 | _x_x_mozilla_page_load_details 19:27:54 INFO - PID 3727 | |i|pagename|runs| 19:27:54 INFO - PID 3727 | |0;dojo.html;3532.2052538178896;3535.6994655454278;3552.129728216584;3571.1072231942017;3583.444566092255;6360.713767880445;6387.329330420309;6451.870962580746;6456.741730330787;6486.286508484075;6392.456641185505;6402.519811014169;6456.580322279048;6461.8061458156335;6485.156929599169;5494.642848214873;5584.329880414356;5631.831045068634;5639.746211420496;5640.351359593637;5650.604457687943;5652.434756524335;5691.174779656947;5725.57058220633;5726.484616384525;5507.118860982264;5603.2435621191025;5671.06427439472;5683.232763576947;5722.7424765885635;5503.394626591112;5505.642133261365;5516.200150978086;5517.337919449652;5566.721663916788;5495.945040549624;5555.777768889239;5563.248961390201;5570.6657600544095;5585.357683866367;6207.068939659087;6217.906731399033;6275.24697036354;6305.621662700252;6318.810435686937;6838.589684618939;6910.758123465705;6914.654267286615;6927.168739751211;6965.547239429421;6917.792466226021;6949.4440444764805;7024.4029257513175;7026.051483049774;7026.26224246457;6442.581232219891;6473.838154046187;6514.869702605969;6545.836354091138;6549.312322206099;7006.824829379204;7066.399356054793;7100.60946647929;7101.573905565682;7115.5730656160795;6848.657567121624;6853.383195512428;6908.481863860231;6911.274316196827;6922.376986071277;6974.895376569356;6979.3020697930815;7024.121984751906;7052.047973523611;7064.116985376828;6758.121444212319;6805.455563554904;6881.759138430231;6882.552634078769;6924.446044316443;6876.931230687729;6914.515983881181;6973.372396484239;6992.650367481606;6996.090508233999;5094.133997220481;5102.540771330598;5152.6650767699975;5165.199394093921;5165.870853228625;4475.820967161277;4561.429821272341;4586.793594288265;4593.63250939924;4600.516945720651;6641.734330626818;6678.666066696645;6718.764843230463;6718.764843230463;6721.025451309532;7003.159620845531;7022.754203602849;7068.505204635626;7077.964610176916;7085.610291434021;6447.516436267299;6479.384458476437;6612.173478315211;6632.933670663231;6721.6975236114495;5855.795047173328;5904.202932604129;5920.585559010828;5937.554683398676;5942.138389933435;7168.92831071693;7180.676869540883;7184.748533801292;7263.0921134858145;7264.927350726425;6897.827554310981;6912.066870972555;6998.720051197895;7078.610676412847;7087.22040575526;7177.210506844347;7193.604351760703;7205.135383753983;7219.927800721925;7240.312170343809;6729.5625784323865;6778.932210678027;6807.591544507345;6810.62541560219;6817.829554261183;6845.281245469353;6880.4839637026425;6903.275156108536;6907.516473846984;6978.965105174441;6702.229243637044;6730.3269673034265;6787.490938179755;6833.726650933907;6840.521163518506;6673.9332606673315;6746.291639377991;6756.054152418567;6759.526833121634;6762.695678694569;6654.567453115532;6659.267480577036;6689.431398331197;6738.326167383222;6750.459963202834;6643.7674681385915;6665.3001434850585;6720.361565651256;6755.560888542229;6768.898466523105;6648.601083934979;6664.600123992576;6684.364985326386;6713.899291510729;6723.159605049369 19:27:54 INFO - PID 3727 | |1;ext.html;892.8125093730314;911.5123408976195;939.6899023322303;963.9710808675734;969.1810420194932;41403.79298103509;43180.3522947156;43267;43267;43518;39766.204675906534;39773.20453590934;39790.40314395286;40091.398629020514;40402.19195616086;7112.715491380339;7167.247439018906;7179.317964793337;7203.13562372516;7237.457190710691;7012.228654847962;7077.929220707804;7079.256678048808;7081.5396999195145;7113.359797618214;7625.237476252358;7864.803379915491;7872.01599800025;7877.330426913691;7888.2506161914525;7767.766966990999;7790.104138024143;7792.961035194844;7817.570033648147;7820.139784623687;7625.961870190669;7649.770506884803;7672.769816905502;7695.538267703956;7723.497972631761;39496;39638.405423918666;39696.80151599253;39765.80117099396;39782.80108599438;3557.4663800429885;3564.269324788412;3596.5863925648364;3600.747947643666;3604.5133906922492;31880.362392752246;32011.83994080038;32098.518522222184;32127.839360803046;32235.67764322374;4943.382077240345;5121.641485096045;5152.458991805881;5156.149235376159;5184.27420161174;211475;216975;218817;220268;230145;53984;54115;54149.45850541444;54166.729166353914;54267;56337.436625634036;56442;56529.15206271909;56691.71654141785;56696.43303566994;15020.774688379683;15051.774223386657;15055.698886022437;15076.698466030617;15106.848931510764;12186.81719774204;12250.203736757083;12266.938665306616;12275.69310767238;12276.508939642314;14682.779758303634;14896.255187240595;14964.625884352978;15004.849951500346;15128.39486420553;5881.794137205177;5905.232319798399;6001.1898393717165;6047.213862197974;6047.244094488189;1073.4203530093662;1089.8503325389631;1097.2154909239932;1119.6920846767205;1126.1947707389093;24388.26835194947;24781.876090619433;24823.751762482145;24965.50068998646;25057;1183.195626669319;1186.8219767035014;1215.4408971873038;1218.214251807579;1224.3633310678397;13241.404136813866;13341.533046343526;13405.798913016117;13464.93267533656;13524.18854868711;294326;298683;298803;300726;301699;61713.38286617077;62327.376726233066;62465.687671561354;62486;62600.68699656473;1494.9701005979819;1509.1473317575753;1525.59571713496;1532.8850336224828;1546.0182783932285;28780;29214;29232.26919327034;29348.706512935452;29808.701912980592;40696.79651601723;40708;40917.38623920584;40926;40943.59056409517;251030;251426;251872;252309;253309;36549.26901462009;40949.59050409458;41406.585934141476;41502;41609.58390416057;50471;51077;51120.74439627778;51609;51646.48353516567;37390.25219495541;38052;38237.808810955765;38264;38601.80699096486;36979.81510092432;37021.44467833039;37277;37357;37864.242715146094;43205;44003.559964399945;44071;44103.33844992264;44209.33685994648;36366.818165909004;36536.45195322019;36628;36663.450048248764;37115.44326835046;26049.609255861556;26712.46575068449;27187.320316992234;27225.455490889675;27902.16293511198 19:27:54 INFO - PID 3727 | |2;jquery.html;570.4381184533236;581.1602234770755;601;603.7434090511534;618.3970628637079;23297.650535241963;23402.414939626517;24063.39841503963;24109.517809643796;24153.516929661397;23825.5234895302;24289.27132186037;24347.87826060867;24376.146834860785;24402.75597244027;6317.9052314215205;6443.323451037644;6450.870982580345;6456.644884531349;6458.547901646886;6312.400321969406;6424.5502814802985;6525.380088891571;6576.769813056544;6587.868242635144;6558.1474408327085;6560.835979100537;6560.901586476183;6561.2782593914635;6561.311062338457;6473.352664733536;6525.119108920282;6547.705353259091;6549.312322206171;6554.082428460019;6056.818295451144;6086.6348019119;6092.847678808021;6114.205153330083;6119.694015299262;28202.871885124776;30062.24844378886;30830.383392332253;30987.22531936697;31158.22104447384;2274.2494976657827;2307.711536057993;2308.4113551044375;2309.56118337517;2309.7805708457836;19935.90032049845;20226.79773202264;20310.08604612796;20322.593548128956;20383.388498345073;2350.294911526535;2354.0701422938014;2381.9880900595385;2400.45170864793;2437.110454684045;156626;158194;158209;159641;160005;15070.547883563511;15942.920285398499;16049.839501605067;16071.758923616155;16526.586835329213;25408.872955635474;25410.618840717405;25469.745302546737;25529.87235063813;25560.744392556207;10207.7448063799;10302.072813446826;10324.638637647797;10589.629362972259;10599;8623.741287761377;9446.197073248713;9469.66856160031;9483.241340692728;9518.571664275125;8768.868466973001;10003.949980250052;10033;10137.239707021856;10360.549523066777;2915.07352574149;2937.500624893773;2963.592293660537;3025.273934255763;3069.892553760608;1056.6618682021679;1076.7792602516465;1085.777415629794;1088.1566785741113;1101.9063379612824;21942.780572194075;22260;22265.443363915707;22366.776332236794;22942.98497762918;1114.6266000889793;1124.2692250037542;1131.236415419605;1141.8743938166795;1160.4487868262677;11871.406429678482;12177.512899484098;12178.878211217952;12229.26624402521;12413.689657758448;552299;559851;567090;567705;578257;131147;132384;132433;132942;133376.3331183338;1297.8183054372396;1308.770965081107;1311.8294621699117;1315.526410492222;1327.037897524268;19022.904885475484;19053;19615.509612259808;19818.90090549538;22873.284503662624;66803;66988.33011669821;67750;68012.3198768006;68045;80763.59618201871;81679;81812;81825.59087204764;81869.18130818616;15610.609734756721;16090.919545402197;16107.677846442772;16137.67724645524;16162.919185403998;25916.35209119787;25953.610695839954;25984.220473385827;26051.348716282246;26219.344516387242;19061.90469047646;19341.903290483457;20459.4885127873;20561.48596285105;20754.377368678965;16601.833981660027;16929.66140677204;17187.484375468757;18455.169517372018;18927.053647317305;20431.79568204299;20983.265585705038;21211.68182477295;21496.67754983645;21545.676814847477;15634.609134771721;16046.919765401099;16084.276207570922;16133.919330403272;16169.27238274304;20516.384508464173;20848.68726969127;20854.165833366496;20971.37085887426;20985.265515706877 19:27:54 INFO - PID 3727 | |3;mootools.html;1407.8169837921068;1476.7932489451473;1482.5107714454232;1503.6767095074556;1511.350119448637;15834.129122898235;15932.20338983049;16233.26950287237;16304.266308016153;16374.935629184094;15955.202239888018;16152.273147708353;16156.596085097879;16183.83816161838;16184.595385115377;2938.338873753399;2967.3471836196054;3024.2741741981877;3025.788194826363;3029.9848500757466;2922.9123126306245;2957.3937342844774;2965.0363631819637;3067.1718635968277;3070.524068769333;2982.4482470742873;3023.969760302391;3046.2079859236537;3049.070033639739;3050.7254347108756;2931.3730879361947;2954.9409011819753;2966.31774691821;2967.74774144198;2972.83649399284;2895.5077636801793;2897.797154199207;2921.868515916789;2923.780716446254;2923.8830446782104;15564.844351556452;15745.685086298325;15817.683646327125;15825.208739562975;15855.52433426999;8493.193146651058;8809.867851982226;8829.0729473405;8837.38138330317;8844.778880527974;5579.8605034874045;5862.530997520188;5879.67661778602;5962.701864906738;5991.910121348184;1845.62164756226;1878.9060546972732;1881.8776779509287;1900.1164458526714;1903.2577294855018;27039.864800676067;27452.17643470699;27474.313142171406;27494.312642183904;27523.31191720203;7379.483436159418;7465.738699145612;7517.661705223278;7587.241275872479;7669.884951725729;18263.178156982704;18592.44222673322;18607.720884186747;18616;18629.813701862808;8233.3824963128;8355.248027677539;8394.412391132562;8421.284190843848;8429.114942931026;7784.3772498200005;7908.209179082046;8192.262696357357;8204.769284607357;8293.087760346358;5604.8038318658655;5912.231409916683;6015.157877897098;6067.120267561268;6110.541709371726;1509.690513444741;1546.1341648676778;1679.1184628070362;1687.5527985083963;1706.7866516685415;979.3585201692903;1002.283367392318;1004.4826914139225;1025.7435641089728;1032.7779527401644;8961.193492585568;9429.669961551313;9872.555734991798;10177.84733229002;10190.541425635864;1084.4252546150553;1090.8091084060416;1104.618906477264;1115.8605174353206;1125.6454216921807;5546.473085056913;5808.506276966421;6054.727537260834;6159.5072394208355;6464.482841372679;22713.886430568073;22864.314070577908;22884.88557557235;23166.18918337884;23296.65055024176;22043.448913777283;22096.44758881041;22941.541169176857;23021;23207.883960580428;12449.688757780947;12484.50061997528;12732.23606583608;12761.170523915916;12767.297798620979;9272.860907086533;9399;9858.30991830565;10097.697069087939;10124.69625911224;19952.700709489658;19953.501162471053;19998.70001949943;20123.496912577302;20228.988550572707;20530.79469205289;20532.38402847917;20588.897055514626;20609.93900609987;20625.69061464109;12809.231446113263;13233;13259.270740109387;13315.800262995868;13316.40076196554;14267.928660356632;14540.200288984208;14754.704905901606;14810.111393316436;14810.62973425673;11836.467358968695;11851.288922664668;11967.76064478723;12005.39973001329;12235.510579577074;11658.41707914584;11674.883251167379;11847.348395837967;11945.940270298594;12109.878901210875;10000.749981250236;10211.132053775214;10216.948915255376;10220;10221.386716797017;7701.3068823806125;7730.7540898649895;7776.805579860549;7781.688732450639;7822.4524283299625;7870.488418252795;8005.679772809022;8069.636866341146;8073.798155046171;8157.8368432632205 19:27:54 INFO - PID 3727 | |4;prototype.html;540.316499627971;543.5189856976574;556.1740814889888;563.9369787949713;564.7599770097708;6258.84352891178;6286.151369565107;6295.811125666238;6322;6323.683815809202;6148.969255153729;6184.288806787221;6187.969060154693;6227.5952063115865;6264.279607845099;5005.5995520358465;5039.546440820325;5046;5048.4311697913445;5057.216131499615;4710.175719249118;4894.486078961711;4976.203807390818;4993.900121997558;5014.2979982802435;4760.54803284998;4829.830955916544;4832.879178020543;4851.514848515156;4859.757012149396;4828.758562071917;4837.443693975203;4875.902921842592;4879.658423910328;4886.560209581137;4387.341898715186;4387.758673272969;4403.965068208969;4465.598096171328;4465.59809617136;6111.816645500642;6125.009371954133;6153.4154255345675;6171.6297022178815;6199.969000155015;5866.274915428691;5868.2371291732225;5873.735681894325;5902.409759024106;5914.137046830235;6578.572392794453;6589.670516474157;6641.601503909781;6645.368689974444;6649.900251496231;5044.571211447032;5049.778097637028;5058.645894787366;5072.771725272371;5077.771500282459;6703.530752847302;6858.211305699859;6866.313368663194;6939.965300173517;7048.859022819566;5017.974910125499;5103.209002604603;5121.257417674491;5166.535011848877;5180.481951804864;5196.142636465017;5227.3465816772905;5243.606729495303;5281.577473802164;5286.101362768339;5752.36723960364;5821.243238378984;5845;5848.707564621752;5850.771338018979;6476.384743449365;6547.607143571401;6550.181227346582;6668.333166683293;6687.364700353459;1792.659394715026;1797.7932537758325;1821.134960893565;1821.8906865588108;1827.2782251010776;1258.2539411807597;1265.6835791052238;1299.7465494228534;1306.0987918336507;1307.7842156044146;6259;6384.936150638434;6436.903446448307;6449.000809748993;6475.546711730228;6817.181938167352;6854;6867.416269617039;6869.931300686929;6875.7937261882225;6232.657203853832;6330.1454303668415;6384.84037899047;6439.130717353098;6446.67766611677;3553.200529880756;3570.8571657133944;3571.8392672329287;3600.117971097098;3640.8361623726996;7019.192792828788;7023.403010744042;7063.92936070643;7082.511053933243;7133.286671332929;6885.724571017103;6965.512414131063;6975.337342952412;7033;7044.92955070453;6952.826179345557;6969.233384327618;6972.26791186918;7042.436605071582;7069.9646501767165;6685.933140668726;6744;6759.526833121634;6824.488163387667;6832.180138383227;6671.39957403836;6741.089952856498;6788;6795.456363491007;6802.489813264124;6936.53752917707;7050.153981522045;7059.399951004222;7096.325849044332;7137;5189.610779191651;5196.68819870809;5209.348831396075;5224.216367544898;5264;6664.266930637529;6789.253182149861;6800.183977922681;6830.692618832264;6922.20394654601;6444.548881578245;6487.708053137714;6488.17764272543;6619.378252328211;6657.2677005528385;6459.192600924885;6510.3489651034515;6515.381038801306;6594.208694956636;6623.536352455282;6469;6550.705218265094;6572.8356791078695;6605.438537724155;6627.072209890715;6560;6576.2766095730385;6655.534112612071;6678.933210667831;6726.461883049246;6411.935880641134;6420.486361091008;6456.354364563506;6464.127342808661;6513.967430162819 19:27:54 INFO - PID 3727 | |5;yui.html;967.7193613851983;978.1881038737848;987.9160271376933;1007.204308596209;1013.9290249682523;19198;19585.902070489665;20082.89958550207;20111.698324525143;23532.64701029486;22043.6693449598;22519.324420267378;22618.88690556549;22649.54700905981;22683.09267629293;1073.1951036722458;1085.8751243606969;1088.5645741703304;1089.2484185911735;1089.5042755546247;1086.440483151178;1087.24979763963;1087.5649740103981;1087.7552550676114;1093.824988001916;1084.9023587877089;1127.2391135983219;1127.4926283172606;1128.0806142993433;1130.4573804573809;1104.276698762312;1105.336797921249;1105.8009558279507;1106.9889301106966;1109.4619109731773;804.7384600004963;809.9271065604124;814;814.2712272516065;814.9714759983432;19963.700544491843;20146.69779953302;20299.28952486656;20723.58552828935;20759.169633214653;21311.25410610621;21542.246021389175;21818.23636172742;21829.235976740896;21905.452363691034;16076.59808504785;17069.48791536256;17135;17169.22738476759;17203.569910752332;3647.3799454092605;3658.487811706363;3660.359437098497;3660.4692319613773;3666.4866918631415;153360.2331988344;153364;153958.23020884936;155148;155283;15819.129947852978;15932.283047262901;15942.362305507882;16264.349426022827;16423.507294781175;32716.83641581777;32944.69387142877;33064;33665.831670841486;33722;9155.954220228856;9190.264778817678;9287.76780580491;9322.813543729088;9335.206507446943;4262.9786851066165;4296.634786043159;4444.755538445416;4460.241758900995;4468.731876087445;5678.659280443104;5816.418358164235;5837.357890632027;5848.590598658053;5854.092615644582;1066.429460238784;1086.2613422872523;1100.7248187953012;1100.873399559061;1109.7669489407153;729.8649749796305;749.8162950077157;751.8158051277362;756.4364548411469;771.6064806948384;12448.377581121089;12546.68633284157;12618.49526018949;12997.545085921947;13268.800967985488;719.442432115115;721.5237942957623;728.4754976416971;731.9560826350436;742.5099434373287;6013.6993150342305;6050.54620903434;6075.362086980892;6200.906986395207;6271.560990730605;129877;129880;131121;131636;135695;112559;113269;115368;115405.4229728846;119483;94247.52876235575;95185.048149519;95822.52088739512;96812.51593742127;98432;11822.290662560274;11861.703457413634;12044.51821927113;12098.697532561404;12157.574484892986;47920.520794791606;48171.75914120407;48684;49075.26387104125;49429;59303.110453344096;59626;59848.40151598428;60567.39432605794;62632.06051909134;16527.586810329838;16583.91708041452;16585.585360366087;16667.49997500077;16709.415170469463;17941.192646330685;17942.910285448488;18038.5490362742;18051.548711282325;18070.5482362942;16780.748288775434;16838.158092095593;16860.325586976385;16881;16963.406280780113;16307.755383669491;16413;16447.424340148038;16471.83528164703;16507.422240221535;16340.264688089303;16341.918290408472;16364.181790910168;16369.09969951664;16484.25820838041;12015.75968480608;12120.878791211975;12330.19853709506;12441.377931103227;12486.812697809359;12512.37438128108;12869.485220591072;15982.760258596363;16330.918345408198;16366.099864507567 19:27:54 INFO - PID 3727 | __end_tp_report 19:27:54 INFO - PID 3727 | __start_cc_report 19:27:54 INFO - PID 3727 | _x_x_mozilla_cycle_collect,303 19:27:54 INFO - PID 3727 | __end_cc_report 19:27:54 INFO - PID 3727 | __startTimestamp1505269674523__endTimestamp 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | ------- Summary: start ------- 19:27:54 INFO - PID 3727 | Number of tests: 6 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | [#0] dojo.html Cycles:165 Average:6380.03 Median:6718.76 stddev:817.93 (12.2%) stddev-sans-first:789.34 19:27:54 INFO - PID 3727 | Values: 3532.2 3535.7 3552.1 3571.1 3583.4 6360.7 6387.3 6451.9 6456.7 6486.3 6392.5 6402.5 6456.6 6461.8 6485.2 5494.6 5584.3 5631.8 5639.7 5640.4 5650.6 5652.4 5691.2 5725.6 5726.5 5507.1 5603.2 5671.1 5683.2 5722.7 5503.4 5505.6 5516.2 5517.3 5566.7 5495.9 5555.8 5563.2 5570.7 5585.4 6207.1 6217.9 6275.2 6305.6 6318.8 6838.6 6910.8 6914.7 6927.2 6965.5 6917.8 6949.4 7024.4 7026.1 7026.3 6442.6 6473.8 6514.9 6545.8 6549.3 7006.8 7066.4 7100.6 7101.6 7115.6 6848.7 6853.4 6908.5 6911.3 6922.4 6974.9 6979.3 7024.1 7052.0 7064.1 6758.1 6805.5 6881.8 6882.6 6924.4 6876.9 6914.5 6973.4 6992.7 6996.1 5094.1 5102.5 5152.7 5165.2 5165.9 4475.8 4561.4 4586.8 4593.6 4600.5 6641.7 6678.7 6718.8 6718.8 6721.0 7003.2 7022.8 7068.5 7078.0 7085.6 6447.5 6479.4 6612.2 6632.9 6721.7 5855.8 5904.2 5920.6 5937.6 5942.1 7168.9 7180.7 7184.7 7263.1 7264.9 6897.8 6912.1 6998.7 7078.6 7087.2 7177.2 7193.6 7205.1 7219.9 7240.3 6729.6 6778.9 6807.6 6810.6 6817.8 6845.3 6880.5 6903.3 6907.5 6979.0 6702.2 6730.3 6787.5 6833.7 6840.5 6673.9 6746.3 6756.1 6759.5 6762.7 6654.6 6659.3 6689.4 6738.3 6750.5 6643.8 6665.3 6720.4 6755.6 6768.9 6648.6 6664.6 6684.4 6713.9 6723.2 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | [#1] ext.html Cycles:180 Average:43893.01 Median:39048.90 stddev:67503.74 (172.9%) stddev-sans-first:67615.89 19:27:54 INFO - PID 3727 | Values: 892.8 911.5 939.7 964.0 969.2 41403.8 43180.4 43267.0 43267.0 43518.0 39766.2 39773.2 39790.4 40091.4 40402.2 7112.7 7167.2 7179.3 7203.1 7237.5 7012.2 7077.9 7079.3 7081.5 7113.4 7625.2 7864.8 7872.0 7877.3 7888.3 7767.8 7790.1 7793.0 7817.6 7820.1 7626.0 7649.8 7672.8 7695.5 7723.5 39496.0 39638.4 39696.8 39765.8 39782.8 3557.5 3564.3 3596.6 3600.7 3604.5 31880.4 32011.8 32098.5 32127.8 32235.7 4943.4 5121.6 5152.5 5156.1 5184.3 211475.0 216975.0 218817.0 220268.0 230145.0 53984.0 54115.0 54149.5 54166.7 54267.0 56337.4 56442.0 56529.2 56691.7 56696.4 15020.8 15051.8 15055.7 15076.7 15106.8 12186.8 12250.2 12266.9 12275.7 12276.5 14682.8 14896.3 14964.6 15004.8 15128.4 5881.8 5905.2 6001.2 6047.2 6047.2 1073.4 1089.9 1097.2 1119.7 1126.2 24388.3 24781.9 24823.8 24965.5 25057.0 1183.2 1186.8 1215.4 1218.2 1224.4 13241.4 13341.5 13405.8 13464.9 13524.2 294326.0 298683.0 298803.0 300726.0 301699.0 61713.4 62327.4 62465.7 62486.0 62600.7 1495.0 1509.1 1525.6 1532.9 1546.0 28780.0 29214.0 29232.3 29348.7 29808.7 40696.8 40708.0 40917.4 40926.0 40943.6 251030.0 251426.0 251872.0 252309.0 253309.0 36549.3 40949.6 41406.6 41502.0 41609.6 50471.0 51077.0 51120.7 51609.0 51646.5 37390.3 38052.0 38237.8 38264.0 38601.8 36979.8 37021.4 37277.0 37357.0 37864.2 43205.0 44003.6 44071.0 44103.3 44209.3 36366.8 36536.5 36628.0 36663.5 37115.4 26049.6 26712.5 27187.3 27225.5 27902.2 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | [#2] jquery.html Cycles:180 Average:39190.03 Median:2308.06 stddev:95381.60 (4132.5%) stddev-sans-first:95605.10 19:27:54 INFO - PID 3727 | Values: 570.4 581.2 601.0 603.7 618.4 23297.7 23402.4 24063.4 24109.5 24153.5 23825.5 24289.3 24347.9 24376.1 24402.8 6317.9 6443.3 6450.9 6456.6 6458.5 6312.4 6424.6 6525.4 6576.8 6587.9 6558.1 6560.8 6560.9 6561.3 6561.3 6473.4 6525.1 6547.7 6549.3 6554.1 6056.8 6086.6 6092.8 6114.2 6119.7 28202.9 30062.2 30830.4 30987.2 31158.2 2274.2 2307.7 2308.4 2309.6 2309.8 19935.9 20226.8 20310.1 20322.6 20383.4 2350.3 2354.1 2382.0 2400.5 2437.1 156626.0 158194.0 158209.0 159641.0 160005.0 15070.5 15942.9 16049.8 16071.8 16526.6 25408.9 25410.6 25469.7 25529.9 25560.7 10207.7 10302.1 10324.6 10589.6 10599.0 8623.7 9446.2 9469.7 9483.2 9518.6 8768.9 10003.9 10033.0 10137.2 10360.5 2915.1 2937.5 2963.6 3025.3 3069.9 1056.7 1076.8 1085.8 1088.2 1101.9 21942.8 22260.0 22265.4 22366.8 22943.0 1114.6 1124.3 1131.2 1141.9 1160.4 11871.4 12177.5 12178.9 12229.3 12413.7 552299.0 559851.0 567090.0 567705.0 578257.0 131147.0 132384.0 132433.0 132942.0 133376.3 1297.8 1308.8 1311.8 1315.5 1327.0 19022.9 19053.0 19615.5 19818.9 22873.3 66803.0 66988.3 67750.0 68012.3 68045.0 80763.6 81679.0 81812.0 81825.6 81869.2 15610.6 16090.9 16107.7 16137.7 16162.9 25916.4 25953.6 25984.2 26051.3 26219.3 19061.9 19341.9 20459.5 20561.5 20754.4 16601.8 16929.7 17187.5 18455.2 18927.1 20431.8 20983.3 21211.7 21496.7 21545.7 15634.6 16046.9 16084.3 16133.9 16169.3 20516.4 20848.7 20854.2 20971.4 20985.3 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | [#3] mootools.html Cycles:180 Average:10069.56 Median:22789.10 stddev:7012.71 (30.8%) stddev-sans-first:7002.18 19:27:54 INFO - PID 3727 | Values: 1407.8 1476.8 1482.5 1503.7 1511.4 15834.1 15932.2 16233.3 16304.3 16374.9 15955.2 16152.3 16156.6 16183.8 16184.6 2938.3 2967.3 3024.3 3025.8 3030.0 2922.9 2957.4 2965.0 3067.2 3070.5 2982.4 3024.0 3046.2 3049.1 3050.7 2931.4 2954.9 2966.3 2967.7 2972.8 2895.5 2897.8 2921.9 2923.8 2923.9 15564.8 15745.7 15817.7 15825.2 15855.5 8493.2 8809.9 8829.1 8837.4 8844.8 5579.9 5862.5 5879.7 5962.7 5991.9 1845.6 1878.9 1881.9 1900.1 1903.3 27039.9 27452.2 27474.3 27494.3 27523.3 7379.5 7465.7 7517.7 7587.2 7669.9 18263.2 18592.4 18607.7 18616.0 18629.8 8233.4 8355.2 8394.4 8421.3 8429.1 7784.4 7908.2 8192.3 8204.8 8293.1 5604.8 5912.2 6015.2 6067.1 6110.5 1509.7 1546.1 1679.1 1687.6 1706.8 979.4 1002.3 1004.5 1025.7 1032.8 8961.2 9429.7 9872.6 10177.8 10190.5 1084.4 1090.8 1104.6 1115.9 1125.6 5546.5 5808.5 6054.7 6159.5 6464.5 22713.9 22864.3 22884.9 23166.2 23296.7 22043.4 22096.4 22941.5 23021.0 23207.9 12449.7 12484.5 12732.2 12761.2 12767.3 9272.9 9399.0 9858.3 10097.7 10124.7 19952.7 19953.5 19998.7 20123.5 20229.0 20530.8 20532.4 20588.9 20609.9 20625.7 12809.2 13233.0 13259.3 13315.8 13316.4 14267.9 14540.2 14754.7 14810.1 14810.6 11836.5 11851.3 11967.8 12005.4 12235.5 11658.4 11674.9 11847.3 11945.9 12109.9 10000.7 10211.1 10216.9 10220.0 10221.4 7701.3 7730.8 7776.8 7781.7 7822.5 7870.5 8005.7 8069.6 8073.8 8157.8 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | [#4] prototype.html Cycles:180 Average:5644.37 Median:6322.84 stddev:1595.66 (25.2%) stddev-sans-first:1553.47 19:27:54 INFO - PID 3727 | Values: 540.3 543.5 556.2 563.9 564.8 6258.8 6286.2 6295.8 6322.0 6323.7 6149.0 6184.3 6188.0 6227.6 6264.3 5005.6 5039.5 5046.0 5048.4 5057.2 4710.2 4894.5 4976.2 4993.9 5014.3 4760.5 4829.8 4832.9 4851.5 4859.8 4828.8 4837.4 4875.9 4879.7 4886.6 4387.3 4387.8 4404.0 4465.6 4465.6 6111.8 6125.0 6153.4 6171.6 6200.0 5866.3 5868.2 5873.7 5902.4 5914.1 6578.6 6589.7 6641.6 6645.4 6649.9 5044.6 5049.8 5058.6 5072.8 5077.8 6703.5 6858.2 6866.3 6940.0 7048.9 5018.0 5103.2 5121.3 5166.5 5180.5 5196.1 5227.3 5243.6 5281.6 5286.1 5752.4 5821.2 5845.0 5848.7 5850.8 6476.4 6547.6 6550.2 6668.3 6687.4 1792.7 1797.8 1821.1 1821.9 1827.3 1258.3 1265.7 1299.7 1306.1 1307.8 6259.0 6384.9 6436.9 6449.0 6475.5 6817.2 6854.0 6867.4 6869.9 6875.8 6232.7 6330.1 6384.8 6439.1 6446.7 3553.2 3570.9 3571.8 3600.1 3640.8 7019.2 7023.4 7063.9 7082.5 7133.3 6885.7 6965.5 6975.3 7033.0 7044.9 6952.8 6969.2 6972.3 7042.4 7070.0 6685.9 6744.0 6759.5 6824.5 6832.2 6671.4 6741.1 6788.0 6795.5 6802.5 6936.5 7050.2 7059.4 7096.3 7137.0 5189.6 5196.7 5209.3 5224.2 5264.0 6664.3 6789.3 6800.2 6830.7 6922.2 6444.5 6487.7 6488.2 6619.4 6657.3 6459.2 6510.3 6515.4 6594.2 6623.5 6469.0 6550.7 6572.8 6605.4 6627.1 6560.0 6576.3 6655.5 6678.9 6726.5 6411.9 6420.5 6456.4 6464.1 6514.0 19:27:54 INFO - PID 3727 | 19:27:54 INFO - PID 3727 | [#5] yui.html Cycles:180 Average:25880.52 Median:17186.40 stddev:37857.14 (220.3%) stddev-sans-first:37917.13 19:27:54 INFO - PID 3727 | Values: 967.7 978.2 987.9 1007.2 1013.9 19198.0 19585.9 20082.9 20111.7 23532.6 22043.7 22519.3 22618.9 22649.5 22683.1 1073.2 1085.9 1088.6 1089.2 1089.5 1086.4 1087.2 1087.6 1087.8 1093.8 1084.9 1127.2 1127.5 1128.1 1130.5 1104.3 1105.3 1105.8 1107.0 1109.5 804.7 809.9 814.0 814.3 815.0 19963.7 20146.7 20299.3 20723.6 20759.2 21311.3 21542.2 21818.2 21829.2 21905.5 16076.6 17069.5 17135.0 17169.2 17203.6 3647.4 3658.5 3660.4 3660.5 3666.5 153360.2 153364.0 153958.2 155148.0 155283.0 15819.1 15932.3 15942.4 16264.3 16423.5 32716.8 32944.7 33064.0 33665.8 33722.0 9156.0 9190.3 9287.8 9322.8 9335.2 4263.0 4296.6 4444.8 4460.2 4468.7 5678.7 5816.4 5837.4 5848.6 5854.1 1066.4 1086.3 1100.7 1100.9 1109.8 729.9 749.8 751.8 756.4 771.6 12448.4 12546.7 12618.5 12997.5 13268.8 719.4 721.5 728.5 732.0 742.5 6013.7 6050.5 6075.4 6200.9 6271.6 129877.0 129880.0 131121.0 131636.0 135695.0 112559.0 113269.0 115368.0 115405.4 119483.0 94247.5 95185.0 95822.5 96812.5 98432.0 11822.3 11861.7 12044.5 12098.7 12157.6 47920.5 48171.8 48684.0 49075.3 49429.0 59303.1 59626.0 59848.4 60567.4 62632.1 16527.6 16583.9 16585.6 16667.5 16709.4 17941.2 17942.9 18038.5 18051.5 18070.5 16780.7 16838.2 16860.3 16881.0 16963.4 16307.8 16413.0 16447.4 16471.8 16507.4 16340.3 16341.9 16364.2 16369.1 16484.3 12015.8 12120.9 12330.2 12441.4 12486.8 12512.4 12869.5 15982.8 16330.9 16366.1 19:27:54 INFO - PID 3727 | -------- Summary: end -------- 19:27:54 INFO - PID 3727 | 19:27:55 INFO - TEST-INFO | 3727: exit 0 19:27:55 INFO - TEST-OK | dromaeo_css | took 1111401ms 19:27:55 INFO - TEST-START | kraken 19:27:55 INFO - Initialising browser for kraken test... 19:27:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59910/getInfo.html -profile /tmp/tmpwhOhXf/profile 19:27:55 INFO - TEST-INFO | started process 4082 (/builds/slave/test/build/application/firefox/firefox http://localhost:59910/getInfo.html) 19:28:00 INFO - TEST-INFO | 4082: exit 0 19:28:00 INFO - Browser initialized. 19:28:00 INFO - Running cycle 1/1 for kraken test... 19:28:00 INFO - TEST-INFO | started process 4249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwhOhXf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:12 INFO - PID 4249 | RSS: Main: 154382336 19:28:12 INFO - PID 4249 | 19:28:14 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59910/tests/kraken/driver.html?testName=audio-beat-detection) 19:28:15 INFO - PID 4249 | RSS: Main: 160747520 19:28:15 INFO - PID 4249 | 19:28:18 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59910/tests/kraken/driver.html?testName=audio-dft) 19:28:18 INFO - PID 4249 | RSS: Main: 161628160 19:28:18 INFO - PID 4249 | 19:28:21 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59910/tests/kraken/driver.html?testName=audio-fft) 19:28:22 INFO - PID 4249 | RSS: Main: 161763328 19:28:22 INFO - PID 4249 | 19:28:24 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59910/tests/kraken/driver.html?testName=audio-oscillator) 19:28:24 INFO - PID 4249 | RSS: Main: 162697216 19:28:24 INFO - PID 4249 | 19:28:26 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:27 INFO - PID 4249 | RSS: Main: 161722368 19:28:27 INFO - PID 4249 | 19:28:30 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59910/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:31 INFO - PID 4249 | RSS: Main: 161878016 19:28:31 INFO - PID 4249 | 19:28:34 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59910/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:35 INFO - PID 4249 | RSS: Main: 165289984 19:28:35 INFO - PID 4249 | 19:28:37 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59910/tests/kraken/driver.html?testName=json-parse-financial) 19:28:38 INFO - PID 4249 | RSS: Main: 165269504 19:28:38 INFO - PID 4249 | 19:28:40 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:40 INFO - PID 4249 | RSS: Main: 165797888 19:28:40 INFO - PID 4249 | 19:28:42 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:43 INFO - PID 4249 | RSS: Main: 165769216 19:28:43 INFO - PID 4249 | 19:28:45 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:45 INFO - PID 4249 | RSS: Main: 162689024 19:28:45 INFO - PID 4249 | 19:28:48 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:48 INFO - PID 4249 | RSS: Main: 162750464 19:28:48 INFO - PID 4249 | 19:28:51 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:52 INFO - PID 4249 | RSS: Main: 162856960 19:28:52 INFO - PID 4249 | 19:28:53 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:59910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59910/tests/kraken/driver.html?testName=ai-astar) 19:28:54 INFO - PID 4249 | RSS: Main: 164548608 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | __start_tp_report 19:28:54 INFO - PID 4249 | _x_x_mozilla_page_load 19:28:54 INFO - PID 4249 | _x_x_mozilla_page_load_details 19:28:54 INFO - PID 4249 | |i|pagename|runs| 19:28:54 INFO - PID 4249 | |0;ai-astar;95;105;101;106;105;105;105;98;106;107 19:28:54 INFO - PID 4249 | |1;audio-beat-detection;134;114;147;161;111;143;136;116;167;118 19:28:54 INFO - PID 4249 | |2;audio-dft;162;161;162;162;159;160;161;162;161;162 19:28:54 INFO - PID 4249 | |3;audio-fft;75;75;74;186;77;76;81;74;184;77 19:28:54 INFO - PID 4249 | |4;audio-oscillator;77;77;123;76;78;79;126;81;77;121 19:28:54 INFO - PID 4249 | |5;imaging-gaussian-blur;115;115;114;114;115;113;113;114;115;113 19:28:54 INFO - PID 4249 | |6;imaging-darkroom;147;147;147;147;147;147;147;148;147;147 19:28:54 INFO - PID 4249 | |7;imaging-desaturate;94;94;95;94;95;95;94;94;94;94 19:28:54 INFO - PID 4249 | |8;json-parse-financial;49;48;55;45;49;49;46;46;48;45 19:28:54 INFO - PID 4249 | |9;json-stringify-tinderbox;52;53;52;52;53;52;52;52;56;53 19:28:54 INFO - PID 4249 | |10;stanford-crypto-aes;73;81;73;73;80;73;73;71;75;78 19:28:54 INFO - PID 4249 | |11;stanford-crypto-ccm;117;115;119;118;114;118;112;118;134;144 19:28:54 INFO - PID 4249 | |12;stanford-crypto-pbkdf2;167;160;172;159;159;157;160;163;166;157 19:28:54 INFO - PID 4249 | |13;stanford-crypto-sha256-iterative;59;60;60;60;59;59;58;57;58;59 19:28:54 INFO - PID 4249 | __end_tp_report 19:28:54 INFO - PID 4249 | __start_cc_report 19:28:54 INFO - PID 4249 | _x_x_mozilla_cycle_collect,832 19:28:54 INFO - PID 4249 | __end_cc_report 19:28:54 INFO - PID 4249 | __startTimestamp1505269734156__endTimestamp 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | ------- Summary: start ------- 19:28:54 INFO - PID 4249 | Number of tests: 14 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#0] ai-astar Cycles:10 Average:103.30 Median:106.00 stddev:3.97 (3.7%) stddev-sans-first:2.86 19:28:54 INFO - PID 4249 | Values: 95.0 105.0 101.0 106.0 105.0 105.0 105.0 98.0 106.0 107.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:139.50 stddev:19.93 (14.3%) stddev-sans-first:21.14 19:28:54 INFO - PID 4249 | Values: 134.0 114.0 147.0 161.0 111.0 143.0 136.0 116.0 167.0 118.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 19:28:54 INFO - PID 4249 | Values: 162.0 161.0 162.0 162.0 159.0 160.0 161.0 162.0 161.0 162.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#3] audio-fft Cycles:10 Average:97.90 Median:75.50 stddev:45.95 (60.9%) stddev-sans-first:47.99 19:28:54 INFO - PID 4249 | Values: 75.0 75.0 74.0 186.0 77.0 76.0 81.0 74.0 184.0 77.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:77.00 stddev:22.04 (28.6%) stddev-sans-first:22.75 19:28:54 INFO - PID 4249 | Values: 77.0 77.0 123.0 76.0 78.0 79.0 126.0 81.0 77.0 121.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.50 stddev:0.88 (0.8%) stddev-sans-first:0.87 19:28:54 INFO - PID 4249 | Values: 115.0 115.0 114.0 114.0 115.0 113.0 113.0 114.0 115.0 113.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 19:28:54 INFO - PID 4249 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:28:54 INFO - PID 4249 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.50 stddev:2.94 (6.1%) stddev-sans-first:3.10 19:28:54 INFO - PID 4249 | Values: 49.0 48.0 55.0 45.0 49.0 49.0 46.0 46.0 48.0 45.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:52.50 stddev:1.25 (2.4%) stddev-sans-first:1.30 19:28:54 INFO - PID 4249 | Values: 52.0 53.0 52.0 52.0 53.0 52.0 52.0 52.0 56.0 53.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.00 stddev:3.43 (4.6%) stddev-sans-first:3.56 19:28:54 INFO - PID 4249 | Values: 73.0 81.0 73.0 73.0 80.0 73.0 73.0 71.0 75.0 78.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:118.00 stddev:10.06 (8.5%) stddev-sans-first:10.57 19:28:54 INFO - PID 4249 | Values: 117.0 115.0 119.0 118.0 114.0 118.0 112.0 118.0 134.0 144.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:161.50 stddev:4.92 (3.0%) stddev-sans-first:4.88 19:28:54 INFO - PID 4249 | Values: 167.0 160.0 172.0 159.0 159.0 157.0 160.0 163.0 166.0 157.0 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.90 Median:59.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 19:28:54 INFO - PID 4249 | Values: 59.0 60.0 60.0 60.0 59.0 59.0 58.0 57.0 58.0 59.0 19:28:54 INFO - PID 4249 | -------- Summary: end -------- 19:28:54 INFO - PID 4249 | 19:28:54 INFO - PID 4249 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:28:54 INFO - TEST-INFO | 4249: exit 0 19:28:54 INFO - TEST-OK | kraken | took 59720ms 19:28:54 INFO - SUITE-END | took 1171s 19:28:55 INFO - Completed test suite (00:19:31) 19:28:55 INFO - javascript benchmark 19:28:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9028.727736271296, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3532.2052538178896, 3535.6994655454278, 3552.129728216584, 3571.1072231942017, 3583.444566092255, 6360.713767880445, 6387.329330420309, 6451.870962580746, 6456.741730330787, 6486.286508484075, 6392.456641185505, 6402.519811014169, 6456.580322279048, 6461.8061458156335, 6485.156929599169, 5494.642848214873, 5584.329880414356, 5631.831045068634, 5639.746211420496, 5640.351359593637, 5650.604457687943, 5652.434756524335, 5691.174779656947, 5725.57058220633, 5726.484616384525, 5507.118860982264, 5603.2435621191025, 5671.06427439472, 5683.232763576947, 5722.7424765885635, 5503.394626591112, 5505.642133261365, 5516.200150978086, 5517.337919449652, 5566.721663916788, 5495.945040549624, 5555.777768889239, 5563.248961390201, 5570.6657600544095, 5585.357683866367, 6207.068939659087, 6217.906731399033, 6275.24697036354, 6305.621662700252, 6318.810435686937, 6838.589684618939, 6910.758123465705, 6914.654267286615, 6927.168739751211, 6965.547239429421, 6917.792466226021, 6949.4440444764805, 7024.4029257513175, 7026.051483049774, 7026.26224246457, 6442.581232219891, 6473.838154046187, 6514.869702605969, 6545.836354091138, 6549.312322206099, 7006.824829379204, 7066.399356054793, 7100.60946647929, 7101.573905565682, 7115.5730656160795, 6848.657567121624, 6853.383195512428, 6908.481863860231, 6911.274316196827, 6922.376986071277, 6974.895376569356, 6979.3020697930815, 7024.121984751906, 7052.047973523611, 7064.116985376828, 6758.121444212319, 6805.455563554904, 6881.759138430231, 6882.552634078769, 6924.446044316443, 6876.931230687729, 6914.515983881181, 6973.372396484239, 6992.650367481606, 6996.090508233999, 5094.133997220481, 5102.540771330598, 5152.6650767699975, 5165.199394093921, 5165.870853228625, 4475.820967161277, 4561.429821272341, 4586.793594288265, 4593.63250939924, 4600.516945720651, 6641.734330626818, 6678.666066696645, 6718.764843230463, 6718.764843230463, 6721.025451309532, 7003.159620845531, 7022.754203602849, 7068.505204635626, 7077.964610176916, 7085.610291434021, 6447.516436267299, 6479.384458476437, 6612.173478315211, 6632.933670663231, 6721.6975236114495, 5855.795047173328, 5904.202932604129, 5920.585559010828, 5937.554683398676, 5942.138389933435, 7168.92831071693, 7180.676869540883, 7184.748533801292, 7263.0921134858145, 7264.927350726425, 6897.827554310981, 6912.066870972555, 6998.720051197895, 7078.610676412847, 7087.22040575526, 7177.210506844347, 7193.604351760703, 7205.135383753983, 7219.927800721925, 7240.312170343809, 6729.5625784323865, 6778.932210678027, 6807.591544507345, 6810.62541560219, 6817.829554261183, 6845.281245469353, 6880.4839637026425, 6903.275156108536, 6907.516473846984, 6978.965105174441, 6702.229243637044, 6730.3269673034265, 6787.490938179755, 6833.726650933907, 6840.521163518506, 6673.9332606673315, 6746.291639377991, 6756.054152418567, 6759.526833121634, 6762.695678694569, 6654.567453115532, 6659.267480577036, 6689.431398331197, 6738.326167383222, 6750.459963202834, 6643.7674681385915, 6665.3001434850585, 6720.361565651256, 6755.560888542229, 6768.898466523105, 6648.601083934979, 6664.600123992576, 6684.364985326386, 6713.899291510729, 6723.159605049369], "value": 6317.559105145758, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.8125093730314, 911.5123408976195, 939.6899023322303, 963.9710808675734, 969.1810420194932, 41403.79298103509, 43180.3522947156, 43267.0, 43267.0, 43518.0, 39766.204675906534, 39773.20453590934, 39790.40314395286, 40091.398629020514, 40402.19195616086, 7112.715491380339, 7167.247439018906, 7179.317964793337, 7203.13562372516, 7237.457190710691, 7012.228654847962, 7077.929220707804, 7079.256678048808, 7081.5396999195145, 7113.359797618214, 7625.237476252358, 7864.803379915491, 7872.01599800025, 7877.330426913691, 7888.2506161914525, 7767.766966990999, 7790.104138024143, 7792.961035194844, 7817.570033648147, 7820.139784623687, 7625.961870190669, 7649.770506884803, 7672.769816905502, 7695.538267703956, 7723.497972631761, 39496.0, 39638.405423918666, 39696.80151599253, 39765.80117099396, 39782.80108599438, 3557.4663800429885, 3564.269324788412, 3596.5863925648364, 3600.747947643666, 3604.5133906922492, 31880.362392752246, 32011.83994080038, 32098.518522222184, 32127.839360803046, 32235.67764322374, 4943.382077240345, 5121.641485096045, 5152.458991805881, 5156.149235376159, 5184.27420161174, 211475.0, 216975.0, 218817.0, 220268.0, 230145.0, 53984.0, 54115.0, 54149.45850541444, 54166.729166353914, 54267.0, 56337.436625634036, 56442.0, 56529.15206271909, 56691.71654141785, 56696.43303566994, 15020.774688379683, 15051.774223386657, 15055.698886022437, 15076.698466030617, 15106.848931510764, 12186.81719774204, 12250.203736757083, 12266.938665306616, 12275.69310767238, 12276.508939642314, 14682.779758303634, 14896.255187240595, 14964.625884352978, 15004.849951500346, 15128.39486420553, 5881.794137205177, 5905.232319798399, 6001.1898393717165, 6047.213862197974, 6047.244094488189, 1073.4203530093662, 1089.8503325389631, 1097.2154909239932, 1119.6920846767205, 1126.1947707389093, 24388.26835194947, 24781.876090619433, 24823.751762482145, 24965.50068998646, 25057.0, 1183.195626669319, 1186.8219767035014, 1215.4408971873038, 1218.214251807579, 1224.3633310678397, 13241.404136813866, 13341.533046343526, 13405.798913016117, 13464.93267533656, 13524.18854868711, 294326.0, 298683.0, 298803.0, 300726.0, 301699.0, 61713.38286617077, 62327.376726233066, 62465.687671561354, 62486.0, 62600.68699656473, 1494.9701005979819, 1509.1473317575753, 1525.59571713496, 1532.8850336224828, 1546.0182783932285, 28780.0, 29214.0, 29232.26919327034, 29348.706512935452, 29808.701912980592, 40696.79651601723, 40708.0, 40917.38623920584, 40926.0, 40943.59056409517, 251030.0, 251426.0, 251872.0, 252309.0, 253309.0, 36549.26901462009, 40949.59050409458, 41406.585934141476, 41502.0, 41609.58390416057, 50471.0, 51077.0, 51120.74439627778, 51609.0, 51646.48353516567, 37390.25219495541, 38052.0, 38237.808810955765, 38264.0, 38601.80699096486, 36979.81510092432, 37021.44467833039, 37277.0, 37357.0, 37864.242715146094, 43205.0, 44003.559964399945, 44071.0, 44103.33844992264, 44209.33685994648, 36366.818165909004, 36536.45195322019, 36628.0, 36663.450048248764, 37115.44326835046, 26049.609255861556, 26712.46575068449, 27187.320316992234, 27225.455490889675, 27902.16293511198], "value": 18570.46374902657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4381184533236, 581.1602234770755, 601.0, 603.7434090511534, 618.3970628637079, 23297.650535241963, 23402.414939626517, 24063.39841503963, 24109.517809643796, 24153.516929661397, 23825.5234895302, 24289.27132186037, 24347.87826060867, 24376.146834860785, 24402.75597244027, 6317.9052314215205, 6443.323451037644, 6450.870982580345, 6456.644884531349, 6458.547901646886, 6312.400321969406, 6424.5502814802985, 6525.380088891571, 6576.769813056544, 6587.868242635144, 6558.1474408327085, 6560.835979100537, 6560.901586476183, 6561.2782593914635, 6561.311062338457, 6473.352664733536, 6525.119108920282, 6547.705353259091, 6549.312322206171, 6554.082428460019, 6056.818295451144, 6086.6348019119, 6092.847678808021, 6114.205153330083, 6119.694015299262, 28202.871885124776, 30062.24844378886, 30830.383392332253, 30987.22531936697, 31158.22104447384, 2274.2494976657827, 2307.711536057993, 2308.4113551044375, 2309.56118337517, 2309.7805708457836, 19935.90032049845, 20226.79773202264, 20310.08604612796, 20322.593548128956, 20383.388498345073, 2350.294911526535, 2354.0701422938014, 2381.9880900595385, 2400.45170864793, 2437.110454684045, 156626.0, 158194.0, 158209.0, 159641.0, 160005.0, 15070.547883563511, 15942.920285398499, 16049.839501605067, 16071.758923616155, 16526.586835329213, 25408.872955635474, 25410.618840717405, 25469.745302546737, 25529.87235063813, 25560.744392556207, 10207.7448063799, 10302.072813446826, 10324.638637647797, 10589.629362972259, 10599.0, 8623.741287761377, 9446.197073248713, 9469.66856160031, 9483.241340692728, 9518.571664275125, 8768.868466973001, 10003.949980250052, 10033.0, 10137.239707021856, 10360.549523066777, 2915.07352574149, 2937.500624893773, 2963.592293660537, 3025.273934255763, 3069.892553760608, 1056.6618682021679, 1076.7792602516465, 1085.777415629794, 1088.1566785741113, 1101.9063379612824, 21942.780572194075, 22260.0, 22265.443363915707, 22366.776332236794, 22942.98497762918, 1114.6266000889793, 1124.2692250037542, 1131.236415419605, 1141.8743938166795, 1160.4487868262677, 11871.406429678482, 12177.512899484098, 12178.878211217952, 12229.26624402521, 12413.689657758448, 552299.0, 559851.0, 567090.0, 567705.0, 578257.0, 131147.0, 132384.0, 132433.0, 132942.0, 133376.3331183338, 1297.8183054372396, 1308.770965081107, 1311.8294621699117, 1315.526410492222, 1327.037897524268, 19022.904885475484, 19053.0, 19615.509612259808, 19818.90090549538, 22873.284503662624, 66803.0, 66988.33011669821, 67750.0, 68012.3198768006, 68045.0, 80763.59618201871, 81679.0, 81812.0, 81825.59087204764, 81869.18130818616, 15610.609734756721, 16090.919545402197, 16107.677846442772, 16137.67724645524, 16162.919185403998, 25916.35209119787, 25953.610695839954, 25984.220473385827, 26051.348716282246, 26219.344516387242, 19061.90469047646, 19341.903290483457, 20459.4885127873, 20561.48596285105, 20754.377368678965, 16601.833981660027, 16929.66140677204, 17187.484375468757, 18455.169517372018, 18927.053647317305, 20431.79568204299, 20983.265585705038, 21211.68182477295, 21496.67754983645, 21545.676814847477, 15634.609134771721, 16046.919765401099, 16084.276207570922, 16133.919330403272, 16169.27238274304, 20516.384508464173, 20848.68726969127, 20854.165833366496, 20971.37085887426, 20985.265515706877], "value": 12865.829226183734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.8169837921068, 1476.7932489451473, 1482.5107714454232, 1503.6767095074556, 1511.350119448637, 15834.129122898235, 15932.20338983049, 16233.26950287237, 16304.266308016153, 16374.935629184094, 15955.202239888018, 16152.273147708353, 16156.596085097879, 16183.83816161838, 16184.595385115377, 2938.338873753399, 2967.3471836196054, 3024.2741741981877, 3025.788194826363, 3029.9848500757466, 2922.9123126306245, 2957.3937342844774, 2965.0363631819637, 3067.1718635968277, 3070.524068769333, 2982.4482470742873, 3023.969760302391, 3046.2079859236537, 3049.070033639739, 3050.7254347108756, 2931.3730879361947, 2954.9409011819753, 2966.31774691821, 2967.74774144198, 2972.83649399284, 2895.5077636801793, 2897.797154199207, 2921.868515916789, 2923.780716446254, 2923.8830446782104, 15564.844351556452, 15745.685086298325, 15817.683646327125, 15825.208739562975, 15855.52433426999, 8493.193146651058, 8809.867851982226, 8829.0729473405, 8837.38138330317, 8844.778880527974, 5579.8605034874045, 5862.530997520188, 5879.67661778602, 5962.701864906738, 5991.910121348184, 1845.62164756226, 1878.9060546972732, 1881.8776779509287, 1900.1164458526714, 1903.2577294855018, 27039.864800676067, 27452.17643470699, 27474.313142171406, 27494.312642183904, 27523.31191720203, 7379.483436159418, 7465.738699145612, 7517.661705223278, 7587.241275872479, 7669.884951725729, 18263.178156982704, 18592.44222673322, 18607.720884186747, 18616.0, 18629.813701862808, 8233.3824963128, 8355.248027677539, 8394.412391132562, 8421.284190843848, 8429.114942931026, 7784.3772498200005, 7908.209179082046, 8192.262696357357, 8204.769284607357, 8293.087760346358, 5604.8038318658655, 5912.231409916683, 6015.157877897098, 6067.120267561268, 6110.541709371726, 1509.690513444741, 1546.1341648676778, 1679.1184628070362, 1687.5527985083963, 1706.7866516685415, 979.3585201692903, 1002.283367392318, 1004.4826914139225, 1025.7435641089728, 1032.7779527401644, 8961.193492585568, 9429.669961551313, 9872.555734991798, 10177.84733229002, 10190.541425635864, 1084.4252546150553, 1090.8091084060416, 1104.618906477264, 1115.8605174353206, 1125.6454216921807, 5546.473085056913, 5808.506276966421, 6054.727537260834, 6159.5072394208355, 6464.482841372679, 22713.886430568073, 22864.314070577908, 22884.88557557235, 23166.18918337884, 23296.65055024176, 22043.448913777283, 22096.44758881041, 22941.541169176857, 23021.0, 23207.883960580428, 12449.688757780947, 12484.50061997528, 12732.23606583608, 12761.170523915916, 12767.297798620979, 9272.860907086533, 9399.0, 9858.30991830565, 10097.697069087939, 10124.69625911224, 19952.700709489658, 19953.501162471053, 19998.70001949943, 20123.496912577302, 20228.988550572707, 20530.79469205289, 20532.38402847917, 20588.897055514626, 20609.93900609987, 20625.69061464109, 12809.231446113263, 13233.0, 13259.270740109387, 13315.800262995868, 13316.40076196554, 14267.928660356632, 14540.200288984208, 14754.704905901606, 14810.111393316436, 14810.62973425673, 11836.467358968695, 11851.288922664668, 11967.76064478723, 12005.39973001329, 12235.510579577074, 11658.41707914584, 11674.883251167379, 11847.348395837967, 11945.940270298594, 12109.878901210875, 10000.749981250236, 10211.132053775214, 10216.948915255376, 10220.0, 10221.386716797017, 7701.3068823806125, 7730.7540898649895, 7776.805579860549, 7781.688732450639, 7822.4524283299625, 7870.488418252795, 8005.679772809022, 8069.636866341146, 8073.798155046171, 8157.8368432632205], "value": 7268.588220999967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.316499627971, 543.5189856976574, 556.1740814889888, 563.9369787949713, 564.7599770097708, 6258.84352891178, 6286.151369565107, 6295.811125666238, 6322.0, 6323.683815809202, 6148.969255153729, 6184.288806787221, 6187.969060154693, 6227.5952063115865, 6264.279607845099, 5005.5995520358465, 5039.546440820325, 5046.0, 5048.4311697913445, 5057.216131499615, 4710.175719249118, 4894.486078961711, 4976.203807390818, 4993.900121997558, 5014.2979982802435, 4760.54803284998, 4829.830955916544, 4832.879178020543, 4851.514848515156, 4859.757012149396, 4828.758562071917, 4837.443693975203, 4875.902921842592, 4879.658423910328, 4886.560209581137, 4387.341898715186, 4387.758673272969, 4403.965068208969, 4465.598096171328, 4465.59809617136, 6111.816645500642, 6125.009371954133, 6153.4154255345675, 6171.6297022178815, 6199.969000155015, 5866.274915428691, 5868.2371291732225, 5873.735681894325, 5902.409759024106, 5914.137046830235, 6578.572392794453, 6589.670516474157, 6641.601503909781, 6645.368689974444, 6649.900251496231, 5044.571211447032, 5049.778097637028, 5058.645894787366, 5072.771725272371, 5077.771500282459, 6703.530752847302, 6858.211305699859, 6866.313368663194, 6939.965300173517, 7048.859022819566, 5017.974910125499, 5103.209002604603, 5121.257417674491, 5166.535011848877, 5180.481951804864, 5196.142636465017, 5227.3465816772905, 5243.606729495303, 5281.577473802164, 5286.101362768339, 5752.36723960364, 5821.243238378984, 5845.0, 5848.707564621752, 5850.771338018979, 6476.384743449365, 6547.607143571401, 6550.181227346582, 6668.333166683293, 6687.364700353459, 1792.659394715026, 1797.7932537758325, 1821.134960893565, 1821.8906865588108, 1827.2782251010776, 1258.2539411807597, 1265.6835791052238, 1299.7465494228534, 1306.0987918336507, 1307.7842156044146, 6259.0, 6384.936150638434, 6436.903446448307, 6449.000809748993, 6475.546711730228, 6817.181938167352, 6854.0, 6867.416269617039, 6869.931300686929, 6875.7937261882225, 6232.657203853832, 6330.1454303668415, 6384.84037899047, 6439.130717353098, 6446.67766611677, 3553.200529880756, 3570.8571657133944, 3571.8392672329287, 3600.117971097098, 3640.8361623726996, 7019.192792828788, 7023.403010744042, 7063.92936070643, 7082.511053933243, 7133.286671332929, 6885.724571017103, 6965.512414131063, 6975.337342952412, 7033.0, 7044.92955070453, 6952.826179345557, 6969.233384327618, 6972.26791186918, 7042.436605071582, 7069.9646501767165, 6685.933140668726, 6744.0, 6759.526833121634, 6824.488163387667, 6832.180138383227, 6671.39957403836, 6741.089952856498, 6788.0, 6795.456363491007, 6802.489813264124, 6936.53752917707, 7050.153981522045, 7059.399951004222, 7096.325849044332, 7137.0, 5189.610779191651, 5196.68819870809, 5209.348831396075, 5224.216367544898, 5264.0, 6664.266930637529, 6789.253182149861, 6800.183977922681, 6830.692618832264, 6922.20394654601, 6444.548881578245, 6487.708053137714, 6488.17764272543, 6619.378252328211, 6657.2677005528385, 6459.192600924885, 6510.3489651034515, 6515.381038801306, 6594.208694956636, 6623.536352455282, 6469.0, 6550.705218265094, 6572.8356791078695, 6605.438537724155, 6627.072209890715, 6560.0, 6576.2766095730385, 6655.534112612071, 6678.933210667831, 6726.461883049246, 6411.935880641134, 6420.486361091008, 6456.354364563506, 6464.127342808661, 6513.967430162819], "value": 5183.714481712383, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [967.7193613851983, 978.1881038737848, 987.9160271376933, 1007.204308596209, 1013.9290249682523, 19198.0, 19585.902070489665, 20082.89958550207, 20111.698324525143, 23532.64701029486, 22043.6693449598, 22519.324420267378, 22618.88690556549, 22649.54700905981, 22683.09267629293, 1073.1951036722458, 1085.8751243606969, 1088.5645741703304, 1089.2484185911735, 1089.5042755546247, 1086.440483151178, 1087.24979763963, 1087.5649740103981, 1087.7552550676114, 1093.824988001916, 1084.9023587877089, 1127.2391135983219, 1127.4926283172606, 1128.0806142993433, 1130.4573804573809, 1104.276698762312, 1105.336797921249, 1105.8009558279507, 1106.9889301106966, 1109.4619109731773, 804.7384600004963, 809.9271065604124, 814.0, 814.2712272516065, 814.9714759983432, 19963.700544491843, 20146.69779953302, 20299.28952486656, 20723.58552828935, 20759.169633214653, 21311.25410610621, 21542.246021389175, 21818.23636172742, 21829.235976740896, 21905.452363691034, 16076.59808504785, 17069.48791536256, 17135.0, 17169.22738476759, 17203.569910752332, 3647.3799454092605, 3658.487811706363, 3660.359437098497, 3660.4692319613773, 3666.4866918631415, 153360.2331988344, 153364.0, 153958.23020884936, 155148.0, 155283.0, 15819.129947852978, 15932.283047262901, 15942.362305507882, 16264.349426022827, 16423.507294781175, 32716.83641581777, 32944.69387142877, 33064.0, 33665.831670841486, 33722.0, 9155.954220228856, 9190.264778817678, 9287.76780580491, 9322.813543729088, 9335.206507446943, 4262.9786851066165, 4296.634786043159, 4444.755538445416, 4460.241758900995, 4468.731876087445, 5678.659280443104, 5816.418358164235, 5837.357890632027, 5848.590598658053, 5854.092615644582, 1066.429460238784, 1086.2613422872523, 1100.7248187953012, 1100.873399559061, 1109.7669489407153, 729.8649749796305, 749.8162950077157, 751.8158051277362, 756.4364548411469, 771.6064806948384, 12448.377581121089, 12546.68633284157, 12618.49526018949, 12997.545085921947, 13268.800967985488, 719.442432115115, 721.5237942957623, 728.4754976416971, 731.9560826350436, 742.5099434373287, 6013.6993150342305, 6050.54620903434, 6075.362086980892, 6200.906986395207, 6271.560990730605, 129877.0, 129880.0, 131121.0, 131636.0, 135695.0, 112559.0, 113269.0, 115368.0, 115405.4229728846, 119483.0, 94247.52876235575, 95185.048149519, 95822.52088739512, 96812.51593742127, 98432.0, 11822.290662560274, 11861.703457413634, 12044.51821927113, 12098.697532561404, 12157.574484892986, 47920.520794791606, 48171.75914120407, 48684.0, 49075.26387104125, 49429.0, 59303.110453344096, 59626.0, 59848.40151598428, 60567.39432605794, 62632.06051909134, 16527.586810329838, 16583.91708041452, 16585.585360366087, 16667.49997500077, 16709.415170469463, 17941.192646330685, 17942.910285448488, 18038.5490362742, 18051.548711282325, 18070.5482362942, 16780.748288775434, 16838.158092095593, 16860.325586976385, 16881.0, 16963.406280780113, 16307.755383669491, 16413.0, 16447.424340148038, 16471.83528164703, 16507.422240221535, 16340.264688089303, 16341.918290408472, 16364.181790910168, 16369.09969951664, 16484.25820838041, 12015.75968480608, 12120.878791211975, 12330.19853709506, 12441.377931103227, 12486.812697809359, 12512.37438128108, 12869.485220591072, 15982.760258596363, 16330.918345408198, 16366.099864507567], "value": 9524.275673903383, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 105.0, 101.0, 106.0, 105.0, 105.0, 105.0, 98.0, 106.0, 107.0], "value": 103.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 114.0, 147.0, 161.0, 111.0, 143.0, 136.0, 116.0, 167.0, 118.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 159.0, 160.0, 161.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 186.0, 77.0, 76.0, 81.0, 74.0, 184.0, 77.0], "value": 97.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 123.0, 76.0, 78.0, 79.0, 126.0, 81.0, 77.0, 121.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 115.0, 113.0, 113.0, 114.0, 115.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 55.0, 45.0, 49.0, 49.0, 46.0, 46.0, 48.0, 45.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 53.0, 52.0, 52.0, 52.0, 56.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 73.0, 73.0, 80.0, 73.0, 73.0, 71.0, 75.0, 78.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 119.0, 118.0, 114.0, 118.0, 112.0, 118.0, 134.0, 144.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 172.0, 159.0, 159.0, 157.0, 160.0, 163.0, 166.0, 157.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 58.0, 57.0, 58.0, 59.0], "value": 58.9, "unit": "score"}]}]} 19:28:55 INFO - Return code: 0 19:28:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:55 INFO - # TBPL SUCCESS # 19:28:55 INFO - Running post-action listener: _package_coverage_data 19:28:55 INFO - Running post-action listener: _resource_record_post_action 19:28:55 INFO - [mozharness: 2017-09-13 02:28:55.436872Z] Finished run-tests step (success) 19:28:55 INFO - Running post-run listener: _resource_record_post_run 19:28:55 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 7667712; Write bytes: 418852864; Read time: 3596; Write time: 365452 19:28:55 INFO - TinderboxPrint: CPU usage
13.0% 19:28:55 INFO - TinderboxPrint: I/O read bytes / time
7,667,712 / 3,596 19:28:55 INFO - TinderboxPrint: I/O write bytes / time
418,852,864 / 365,452 19:28:55 INFO - TinderboxPrint: CPU idle
8,230.1 (86.9%) 19:28:55 INFO - TinderboxPrint: CPU user
1,181.8 (12.5%) 19:28:55 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13148160; Read time: 0; Write time: 4748 19:28:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:28:55 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 5427200; Write bytes: 405704704; Read time: 3408; Write time: 360704 19:28:56 INFO - Running post-run listener: _upload_blobber_files 19:28:56 INFO - Blob upload gear active. 19:28:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:56 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 19:28:56 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'] 19:28:56 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 19:28:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:57 INFO - (blobuploader) - INFO - Done attempting. 19:28:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:01 INFO - (blobuploader) - INFO - Done attempting. 19:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:02 INFO - (blobuploader) - INFO - Done attempting. 19:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:03 INFO - (blobuploader) - INFO - Done attempting. 19:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:29:03 INFO - Return code: 0 19:29:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:29:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/738867aa0c0371968faa10f7ef423b2688d3bd405b1f8fa4280612dbf5eec0d9224685e9dbeb128c341230c309306bc551658dbe28a9047b8db572ea4f21d5b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74542884e0583a4636418f3edf815a18a9c34ff1be73ce9ab7c487940b6c7f7b69bbe91cdd2113d7a08b00ce2a1d139cecb7147c0906482b792f8ffc68f75dcd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ebe930e917a47ae68d0ade957b9734e70f5e23e1d2cb2fb06cedd447d5096d80483b8af5681a0cb8ff5c54fcf62efa29942699da959edb7eca8c71387b345d31", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efceecd373884e72f04eb7d4a5759c43e0a716f01f7c15ee16e4b37d12f4601a007e81555bbd3376fea39898811d1b52fe0a9337d9edbd56de5c7195fbb7a4e0"} 19:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:29:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:29:03 INFO - Contents: 19:29:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/738867aa0c0371968faa10f7ef423b2688d3bd405b1f8fa4280612dbf5eec0d9224685e9dbeb128c341230c309306bc551658dbe28a9047b8db572ea4f21d5b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74542884e0583a4636418f3edf815a18a9c34ff1be73ce9ab7c487940b6c7f7b69bbe91cdd2113d7a08b00ce2a1d139cecb7147c0906482b792f8ffc68f75dcd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ebe930e917a47ae68d0ade957b9734e70f5e23e1d2cb2fb06cedd447d5096d80483b8af5681a0cb8ff5c54fcf62efa29942699da959edb7eca8c71387b345d31", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efceecd373884e72f04eb7d4a5759c43e0a716f01f7c15ee16e4b37d12f4601a007e81555bbd3376fea39898811d1b52fe0a9337d9edbd56de5c7195fbb7a4e0"} 19:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:29:03 INFO - Copying logs to upload dir... 19:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs 19:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.493660 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-12 19:29:03.125484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 19:29:03.133210) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051 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/738867aa0c0371968faa10f7ef423b2688d3bd405b1f8fa4280612dbf5eec0d9224685e9dbeb128c341230c309306bc551658dbe28a9047b8db572ea4f21d5b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74542884e0583a4636418f3edf815a18a9c34ff1be73ce9ab7c487940b6c7f7b69bbe91cdd2113d7a08b00ce2a1d139cecb7147c0906482b792f8ffc68f75dcd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ebe930e917a47ae68d0ade957b9734e70f5e23e1d2cb2fb06cedd447d5096d80483b8af5681a0cb8ff5c54fcf62efa29942699da959edb7eca8c71387b345d31", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efceecd373884e72f04eb7d4a5759c43e0a716f01f7c15ee16e4b37d12f4601a007e81555bbd3376fea39898811d1b52fe0a9337d9edbd56de5c7195fbb7a4e0"} build_url:https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/cT48ck20TeqGgnCaSlrHrQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/738867aa0c0371968faa10f7ef423b2688d3bd405b1f8fa4280612dbf5eec0d9224685e9dbeb128c341230c309306bc551658dbe28a9047b8db572ea4f21d5b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74542884e0583a4636418f3edf815a18a9c34ff1be73ce9ab7c487940b6c7f7b69bbe91cdd2113d7a08b00ce2a1d139cecb7147c0906482b792f8ffc68f75dcd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ebe930e917a47ae68d0ade957b9734e70f5e23e1d2cb2fb06cedd447d5096d80483b8af5681a0cb8ff5c54fcf62efa29942699da959edb7eca8c71387b345d31", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efceecd373884e72f04eb7d4a5759c43e0a716f01f7c15ee16e4b37d12f4601a007e81555bbd3376fea39898811d1b52fe0a9337d9edbd56de5c7195fbb7a4e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 19:29:03.167398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:29:03.167802) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505253774.623893-1015675051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 19:29:03.252689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 19:29:03.253006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 19:29:03.253360) ========= ========= Total master_lag: 0.39 =========