builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1495619636.82 results: success (0) revision: ffaa07672466b06cd748b07a34cf95377afdde41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:56.823393) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:56.823823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:56.824116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:56.839308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:56.839577) ========= 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=eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 02:53:56-- 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% 49.8M=0s 2017-05-24 02:53:57 (49.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:57.009871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:57.013201) ========= 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=eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:57.062807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 02:53:57.066175) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffaa07672466b06cd748b07a34cf95377afdde41 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ffaa07672466b06cd748b07a34cf95377afdde41 --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=eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 02:53:57,228 truncating revision to first 12 chars 2017-05-24 02:53:57,228 Setting DEBUG logging. 2017-05-24 02:53:57,228 attempt 1/10 2017-05-24 02:53:57,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffaa07672466?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 02:53:58,380 unpacking tar archive at: mozilla-central-ffaa07672466/testing/mozharness/ program finished with exit code 0 elapsedTime=1.438024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 02:53:58.519171) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:58.519486) ========= script_repo_revision: ffaa07672466b06cd748b07a34cf95377afdde41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:58.519850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:58.520125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 02:53:58.528528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-24 02:53:58.528787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:53:58 INFO - MultiFileLogger online at 20170524 02:53:58 in /builds/slave/test 02:53:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:53:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:53:58 INFO - {'append_to_log': False, 02:53:58 INFO - 'base_work_dir': '/builds/slave/test', 02:53:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:53:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:53:58 INFO - 'branch': 'Firefox-Non-PGO', 02:53:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:53:58 INFO - 'config_files': ('talos/linux_config.py',), 02:53:58 INFO - 'default_actions': ('clobber', 02:53:58 INFO - 'read-buildbot-config', 02:53:58 INFO - 'download-and-extract', 02:53:58 INFO - 'populate-webroot', 02:53:58 INFO - 'create-virtualenv', 02:53:58 INFO - 'install', 02:53:58 INFO - 'run-tests'), 02:53:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:53:58 INFO - 'download_minidump_stackwalk': True, 02:53:58 INFO - 'download_symbols': 'ondemand', 02:53:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:53:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:53:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:53:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:53:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:53:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:53:58 INFO - 'gecko_profile': False, 02:53:58 INFO - 'gecko_profile_interval': 0, 02:53:58 INFO - 'installer_path': 'installer.exe', 02:53:58 INFO - 'log_level': 'info', 02:53:58 INFO - 'log_name': 'talos', 02:53:58 INFO - 'log_to_console': True, 02:53:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:53:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:53:58 INFO - 'opt_config_files': (), 02:53:58 INFO - 'pip_index': False, 02:53:58 INFO - 'suite': 'dromaeojs-e10s', 02:53:58 INFO - 'system_bits': '32', 02:53:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:53:58 INFO - 'title': 'talos-linux64-ix-010', 02:53:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:53:58 INFO - 'use_talos_json': True, 02:53:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:53:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:53:58 INFO - 'work_dir': 'build'} 02:53:58 INFO - [mozharness: 2017-05-24 09:53:58.791408Z] Running clobber step. 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: clobber 02:53:58 INFO - rmtree: /builds/slave/test/build 02:53:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:53:59 INFO - Running post-action listener: _resource_record_post_action 02:53:59 INFO - [mozharness: 2017-05-24 09:53:59.847468Z] Finished clobber step (success) 02:53:59 INFO - [mozharness: 2017-05-24 09:53:59.847570Z] Running read-buildbot-config step. 02:53:59 INFO - Running pre-action listener: _resource_record_pre_action 02:53:59 INFO - Running main action method: read_buildbot_config 02:53:59 INFO - Using buildbot properties: 02:53:59 INFO - { 02:53:59 INFO - "project": "", 02:53:59 INFO - "product": "firefox", 02:53:59 INFO - "who": "archaeopteryx@coole-files.de", 02:53:59 INFO - "installer_path": "public/build/target.tar.bz2", 02:53:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:53:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:53:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:53:59 INFO - "stage_platform": "linux64", 02:53:59 INFO - "basedir": "/builds/slave/test", 02:53:59 INFO - "buildnumber": 627, 02:53:59 INFO - "platform": "ubuntu64_hw", 02:53:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:53:59 INFO - "slavebuilddir": "test", 02:53:59 INFO - "taskId": "WSrepBaBT1y1u48dD0OvJg", 02:53:59 INFO - "branch": "mozilla-central", 02:53:59 INFO - "script_repo_revision": "production", 02:53:59 INFO - "revision": "ffaa07672466b06cd748b07a34cf95377afdde41", 02:53:59 INFO - "slavename": "talos-linux64-ix-010", 02:53:59 INFO - "repo_path": "mozilla-central" 02:53:59 INFO - } 02:53:59 INFO - Finding installer, test and symbols from parent task. 02:53:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WSrepBaBT1y1u48dD0OvJg'}, attempt #1 02:54:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WSrepBaBT1y1u48dD0OvJg'}, attempt #1 02:54:00 INFO - Task dependencies: J_x_erhcTjyJTsobOHq_8w 02:54:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w'}, attempt #1 02:54:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2 02:54:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/test_packages.json 02:54:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.crashreporter-symbols.zip 02:54:01 INFO - Running post-action listener: _resource_record_post_action 02:54:01 INFO - [mozharness: 2017-05-24 09:54:01.197468Z] Finished read-buildbot-config step (success) 02:54:01 INFO - [mozharness: 2017-05-24 09:54:01.197688Z] Running download-and-extract step. 02:54:01 INFO - Running pre-action listener: _resource_record_pre_action 02:54:01 INFO - Running main action method: download_and_extract 02:54:01 INFO - mkdir: /builds/slave/test/build/tests 02:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:01 INFO - trying https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.test_packages.json 02:54:01 INFO - Downloading https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:54:01 INFO - Downloaded 986 bytes. 02:54:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:54:01 INFO - Using the following test package requirements: 02:54:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:54:01 INFO - u'common': [u'target.common.tests.zip'], 02:54:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:54:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:54:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:54:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:54:01 INFO - u'mozbase': [u'target.common.tests.zip'], 02:54:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:54:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:54:01 INFO - u'web-platform': [u'target.common.tests.zip', 02:54:01 INFO - u'target.web-platform.tests.zip'], 02:54:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:54:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:54:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.common.tests.zip 02:54:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:54:01 INFO - Fetch https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.common.tests.zip into memory 02:54:02 INFO - Content-Length response header: 63523791 02:54:02 INFO - Bytes received: 63523791 02:54:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:54:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.common.tests.zip 02:54:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:54:13 INFO - Fetch https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.common.tests.zip into memory 02:54:14 INFO - Content-Length response header: 63523791 02:54:14 INFO - Bytes received: 63523791 02:54:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.talos.tests.zip 02:54:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:54:26 INFO - Fetch https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.talos.tests.zip into memory 02:54:27 INFO - Content-Length response header: 14411859 02:54:27 INFO - Bytes received: 14411859 02:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:27 INFO - trying https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2 02:54:27 INFO - Downloading https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:54:28 INFO - Downloaded 54896236 bytes. 02:54:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2 02:54:28 INFO - mkdir: /builds/slave/test/properties 02:54:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:28 INFO - Contents: 02:54:28 INFO - build_url:https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2 02:54:28 INFO - Running post-action listener: _resource_record_post_action 02:54:28 INFO - Running post-action listener: set_extra_try_arguments 02:54:28 INFO - [mozharness: 2017-05-24 09:54:28.939267Z] Finished download-and-extract step (success) 02:54:28 INFO - [mozharness: 2017-05-24 09:54:28.939365Z] Running populate-webroot step. 02:54:28 INFO - Running pre-action listener: _resource_record_pre_action 02:54:28 INFO - Running main action method: populate_webroot 02:54:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:28 INFO - '--tppagecycles', 02:54:28 INFO - '7'], 02:54:28 INFO - 'tests': ['tsvgm']}}, 02:54:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:54:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:54:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:54:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:54:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['damp', 'tps']}, 02:54:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'tests': ['damp', 'tps']}, 02:54:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['dromaeo_dom']}, 02:54:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:54:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:54:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:54:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['a11yr', 02:54:28 INFO - 'ts_paint', 02:54:28 INFO - 'tpaint', 02:54:28 INFO - 'sessionrestore', 02:54:28 INFO - 'sessionrestore_no_auto_restore', 02:54:28 INFO - 'tabpaint']}, 02:54:28 INFO - 'other-e10s': {'tests': ['a11yr', 02:54:28 INFO - 'ts_paint', 02:54:28 INFO - 'tpaint', 02:54:28 INFO - 'sessionrestore', 02:54:28 INFO - 'sessionrestore_no_auto_restore', 02:54:28 INFO - 'tabpaint']}, 02:54:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:54:28 INFO - 'ts_paint', 02:54:28 INFO - 'tpaint', 02:54:28 INFO - 'sessionrestore', 02:54:28 INFO - 'sessionrestore_no_auto_restore', 02:54:28 INFO - 'tabpaint']}, 02:54:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:54:28 INFO - 'ts_paint', 02:54:28 INFO - 'tpaint', 02:54:28 INFO - 'sessionrestore', 02:54:28 INFO - 'sessionrestore_no_auto_restore', 02:54:28 INFO - 'tabpaint']}, 02:54:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['a11yr', 02:54:28 INFO - 'ts_paint', 02:54:28 INFO - 'tpaint', 02:54:28 INFO - 'sessionrestore', 02:54:28 INFO - 'sessionrestore_no_auto_restore', 02:54:28 INFO - 'tabpaint']}, 02:54:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['a11yr', 02:54:28 INFO - 'ts_paint', 02:54:28 INFO - 'tpaint', 02:54:28 INFO - 'sessionrestore', 02:54:28 INFO - 'sessionrestore_no_auto_restore', 02:54:28 INFO - 'tabpaint']}, 02:54:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:54:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:54:28 INFO - 'bloom_basic_ref']}, 02:54:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['tsvgx', 02:54:28 INFO - 'tsvgr_opacity', 02:54:28 INFO - 'tart', 02:54:28 INFO - 'tscrollx', 02:54:28 INFO - 'cart', 02:54:28 INFO - 'tsvg_static']}, 02:54:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:54:28 INFO - 'tsvgr_opacity', 02:54:28 INFO - 'tart', 02:54:28 INFO - 'tscrollx', 02:54:28 INFO - 'cart', 02:54:28 INFO - 'tsvg_static']}, 02:54:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'talos_options': ['--disable-e10s'], 02:54:28 INFO - 'tests': ['tp5o']}, 02:54:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:54:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'talos_options': ['--disable-e10s', 02:54:28 INFO - '--xperf_path', 02:54:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:28 INFO - 'tests': ['tp5n']}, 02:54:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:54:28 INFO - 'talos_options': ['--xperf_path', 02:54:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:28 INFO - 'tests': ['tp5n']}}, 02:54:28 INFO - 'talos.zip': {'path': '', 02:54:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:28 INFO - Running post-action listener: _resource_record_post_action 02:54:28 INFO - [mozharness: 2017-05-24 09:54:28.953363Z] Finished populate-webroot step (success) 02:54:28 INFO - [mozharness: 2017-05-24 09:54:28.953452Z] Running create-virtualenv step. 02:54:28 INFO - Running pre-action listener: _resource_record_pre_action 02:54:28 INFO - Running main action method: create_virtualenv 02:54:28 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:28 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 02:54:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:29 INFO - Using real prefix '/usr' 02:54:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:29 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:31 INFO - Installing pip.................done. 02:54:31 INFO - Return code: 0 02:54:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:54:31 INFO - Reading from file tmpfile_stdout 02:54:31 INFO - Output received: 02:54:31 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) 02:54:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54:31 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')]} 02:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:31 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')]} 02:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:31 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:31 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 02:54:31 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 02:54:31 INFO - Using env: {'DISPLAY': ':0', 02:54:31 INFO - 'HOME': '/home/cltbld', 02:54:31 INFO - 'LANG': 'en_US.UTF-8', 02:54:31 INFO - 'LANGUAGE': 'en_US:en', 02:54:31 INFO - 'LOGNAME': 'cltbld', 02:54:31 INFO - 'MAIL': '/var/mail/cltbld', 02:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:31 INFO - 'MOZ_NO_REMOTE': '1', 02:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:31 INFO - 'NO_EM_RESTART': '1', 02:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:31 INFO - 'PWD': '/builds/slave/test', 02:54:31 INFO - 'SHELL': '/bin/bash', 02:54:31 INFO - 'SHLVL': '1', 02:54:31 INFO - 'TERM': 'linux', 02:54:31 INFO - 'TMOUT': '86400', 02:54:31 INFO - 'USER': 'cltbld', 02:54:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:31 INFO - '_': '/tools/buildbot/bin/python'} 02:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:31 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 02:54:31 INFO - Cleaning up... 02:54:31 INFO - Return code: 0 02:54:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:54:31 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')]} 02:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:31 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')]} 02:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:31 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:31 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 02:54:31 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 02:54:32 INFO - Using env: {'DISPLAY': ':0', 02:54:32 INFO - 'HOME': '/home/cltbld', 02:54:32 INFO - 'LANG': 'en_US.UTF-8', 02:54:32 INFO - 'LANGUAGE': 'en_US:en', 02:54:32 INFO - 'LOGNAME': 'cltbld', 02:54:32 INFO - 'MAIL': '/var/mail/cltbld', 02:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:32 INFO - 'MOZ_NO_REMOTE': '1', 02:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:32 INFO - 'NO_EM_RESTART': '1', 02:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:32 INFO - 'PWD': '/builds/slave/test', 02:54:32 INFO - 'SHELL': '/bin/bash', 02:54:32 INFO - 'SHLVL': '1', 02:54:32 INFO - 'TERM': 'linux', 02:54:32 INFO - 'TMOUT': '86400', 02:54:32 INFO - 'USER': 'cltbld', 02:54:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:32 INFO - '_': '/tools/buildbot/bin/python'} 02:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:32 INFO - Downloading/unpacking psutil>=3.1.1 02:54:32 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 02:54:32 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 02:54:32 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 02:54:32 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 02:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:33 INFO - Installing collected packages: psutil 02:54:33 INFO - Running setup.py install for psutil 02:54:33 INFO - building 'psutil._psutil_linux' extension 02:54:33 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 02:54:33 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 02:54:33 INFO - building 'psutil._psutil_posix' extension 02:54:33 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 02:54:33 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 02:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:33 INFO - Successfully installed psutil 02:54:33 INFO - Cleaning up... 02:54:33 INFO - Return code: 0 02:54:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:54:33 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')]} 02:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:33 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')]} 02:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:33 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:33 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 02:54:33 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 02:54:33 INFO - Using env: {'DISPLAY': ':0', 02:54:33 INFO - 'HOME': '/home/cltbld', 02:54:33 INFO - 'LANG': 'en_US.UTF-8', 02:54:33 INFO - 'LANGUAGE': 'en_US:en', 02:54:33 INFO - 'LOGNAME': 'cltbld', 02:54:33 INFO - 'MAIL': '/var/mail/cltbld', 02:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:33 INFO - 'MOZ_NO_REMOTE': '1', 02:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:33 INFO - 'NO_EM_RESTART': '1', 02:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:33 INFO - 'PWD': '/builds/slave/test', 02:54:33 INFO - 'SHELL': '/bin/bash', 02:54:33 INFO - 'SHLVL': '1', 02:54:33 INFO - 'TERM': 'linux', 02:54:33 INFO - 'TMOUT': '86400', 02:54:33 INFO - 'USER': 'cltbld', 02:54:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:33 INFO - '_': '/tools/buildbot/bin/python'} 02:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:54:34 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 02:54:34 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 02:54:34 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 02:54:34 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 02:54:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:54:35 INFO - Installing collected packages: mozsystemmonitor 02:54:35 INFO - Running setup.py install for mozsystemmonitor 02:54:35 INFO - Successfully installed mozsystemmonitor 02:54:35 INFO - Cleaning up... 02:54:35 INFO - Return code: 0 02:54:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:54:35 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')]} 02:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:35 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')]} 02:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:35 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:35 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 02:54:35 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 02:54:35 INFO - Using env: {'DISPLAY': ':0', 02:54:35 INFO - 'HOME': '/home/cltbld', 02:54:35 INFO - 'LANG': 'en_US.UTF-8', 02:54:35 INFO - 'LANGUAGE': 'en_US:en', 02:54:35 INFO - 'LOGNAME': 'cltbld', 02:54:35 INFO - 'MAIL': '/var/mail/cltbld', 02:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:35 INFO - 'MOZ_NO_REMOTE': '1', 02:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:35 INFO - 'NO_EM_RESTART': '1', 02:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:35 INFO - 'PWD': '/builds/slave/test', 02:54:35 INFO - 'SHELL': '/bin/bash', 02:54:35 INFO - 'SHLVL': '1', 02:54:35 INFO - 'TERM': 'linux', 02:54:35 INFO - 'TMOUT': '86400', 02:54:35 INFO - 'USER': 'cltbld', 02:54:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:35 INFO - '_': '/tools/buildbot/bin/python'} 02:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:54:35 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 02:54:35 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 02:54:35 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 02:54:35 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 02:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:54:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:54:36 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 02:54:36 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 02:54:36 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 02:54:36 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 02:54:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:54:36 INFO - warning: no files found matching '*.txt' 02:54:36 INFO - no previously-included directories found matching 'build' 02:54:36 INFO - no previously-included directories found matching 'dist' 02:54:36 INFO - no previously-included directories found matching '.git*' 02:54:36 INFO - Installing collected packages: jsonschema, functools32 02:54:36 INFO - Running setup.py install for functools32 02:54:37 INFO - warning: no files found matching '*.txt' 02:54:37 INFO - no previously-included directories found matching 'build' 02:54:37 INFO - no previously-included directories found matching 'dist' 02:54:37 INFO - no previously-included directories found matching '.git*' 02:54:37 INFO - Successfully installed jsonschema functools32 02:54:37 INFO - Cleaning up... 02:54:37 INFO - Return code: 0 02:54:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:54:37 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')]} 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:37 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')]} 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:37 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:37 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 02:54:37 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 02:54:37 INFO - Using env: {'DISPLAY': ':0', 02:54:37 INFO - 'HOME': '/home/cltbld', 02:54:37 INFO - 'LANG': 'en_US.UTF-8', 02:54:37 INFO - 'LANGUAGE': 'en_US:en', 02:54:37 INFO - 'LOGNAME': 'cltbld', 02:54:37 INFO - 'MAIL': '/var/mail/cltbld', 02:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:37 INFO - 'MOZ_NO_REMOTE': '1', 02:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:37 INFO - 'NO_EM_RESTART': '1', 02:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:37 INFO - 'PWD': '/builds/slave/test', 02:54:37 INFO - 'SHELL': '/bin/bash', 02:54:37 INFO - 'SHLVL': '1', 02:54:37 INFO - 'TERM': 'linux', 02:54:37 INFO - 'TMOUT': '86400', 02:54:37 INFO - 'USER': 'cltbld', 02:54:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:37 INFO - '_': '/tools/buildbot/bin/python'} 02:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:54:37 INFO - Cleaning up... 02:54:37 INFO - Return code: 0 02:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:54:37 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')]} 02:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:37 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')]} 02:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:37 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:37 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 02:54:37 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 02:54:37 INFO - Using env: {'DISPLAY': ':0', 02:54:37 INFO - 'HOME': '/home/cltbld', 02:54:37 INFO - 'LANG': 'en_US.UTF-8', 02:54:37 INFO - 'LANGUAGE': 'en_US:en', 02:54:37 INFO - 'LOGNAME': 'cltbld', 02:54:37 INFO - 'MAIL': '/var/mail/cltbld', 02:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:37 INFO - 'MOZ_NO_REMOTE': '1', 02:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:37 INFO - 'NO_EM_RESTART': '1', 02:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:37 INFO - 'PWD': '/builds/slave/test', 02:54:37 INFO - 'SHELL': '/bin/bash', 02:54:37 INFO - 'SHLVL': '1', 02:54:37 INFO - 'TERM': 'linux', 02:54:37 INFO - 'TMOUT': '86400', 02:54:37 INFO - 'USER': 'cltbld', 02:54:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:37 INFO - '_': '/tools/buildbot/bin/python'} 02:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:54:37 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 02:54:37 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 02:54:37 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 02:54:37 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 02:54:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:54:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:54:38 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 02:54:38 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 02:54:38 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 02:54:38 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 02:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:54:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:54:39 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 02:54:39 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 02:54:39 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 02:54:39 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 02:54:39 INFO - Downloading docopt-0.6.1.tar.gz 02:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:54:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:54:39 INFO - Running setup.py install for blobuploader 02:54:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:54:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:54:39 INFO - Running setup.py install for requests 02:54:39 INFO - Running setup.py install for docopt 02:54:39 INFO - Successfully installed blobuploader requests docopt 02:54:39 INFO - Cleaning up... 02:54:39 INFO - Return code: 0 02:54:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:39 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')]} 02:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:39 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')]} 02:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:39 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:39 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 02:54:39 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 02:54:39 INFO - Using env: {'DISPLAY': ':0', 02:54:39 INFO - 'HOME': '/home/cltbld', 02:54:39 INFO - 'LANG': 'en_US.UTF-8', 02:54:39 INFO - 'LANGUAGE': 'en_US:en', 02:54:39 INFO - 'LOGNAME': 'cltbld', 02:54:39 INFO - 'MAIL': '/var/mail/cltbld', 02:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:39 INFO - 'MOZ_NO_REMOTE': '1', 02:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:39 INFO - 'NO_EM_RESTART': '1', 02:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:39 INFO - 'PWD': '/builds/slave/test', 02:54:39 INFO - 'SHELL': '/bin/bash', 02:54:39 INFO - 'SHLVL': '1', 02:54:39 INFO - 'TERM': 'linux', 02:54:39 INFO - 'TMOUT': '86400', 02:54:39 INFO - 'USER': 'cltbld', 02:54:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:39 INFO - '_': '/tools/buildbot/bin/python'} 02:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:40 INFO - Running setup.py (path:/tmp/pip-nlV_1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:40 INFO - Running setup.py (path:/tmp/pip-zGFHwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:40 INFO - Running setup.py (path:/tmp/pip-A1LcUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:40 INFO - Running setup.py (path:/tmp/pip-8Abtjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:40 INFO - Running setup.py (path:/tmp/pip-E6xDRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:40 INFO - Running setup.py (path:/tmp/pip-R9uaZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:40 INFO - Running setup.py (path:/tmp/pip-iZHF3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:40 INFO - Running setup.py (path:/tmp/pip-gixbZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:40 INFO - Running setup.py (path:/tmp/pip-Q617F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:40 INFO - Running setup.py (path:/tmp/pip-ptzZ1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:40 INFO - Running setup.py (path:/tmp/pip-SjnH5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:40 INFO - Running setup.py (path:/tmp/pip-mZqF2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:40 INFO - Running setup.py (path:/tmp/pip-FLqr72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:40 INFO - Running setup.py (path:/tmp/pip-4_Law6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:41 INFO - Running setup.py (path:/tmp/pip-jEcMOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:41 INFO - Running setup.py (path:/tmp/pip-1zjIaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:41 INFO - Running setup.py (path:/tmp/pip-QYglYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:54:41 INFO - Running setup.py install for manifestparser 02:54:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:54:41 INFO - Running setup.py install for mozcrash 02:54:41 INFO - Running setup.py install for mozdebug 02:54:41 INFO - Running setup.py install for mozdevice 02:54:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:54:41 INFO - Running setup.py install for mozfile 02:54:41 INFO - Running setup.py install for mozhttpd 02:54:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:54:41 INFO - Running setup.py install for mozinfo 02:54:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:54:41 INFO - Running setup.py install for mozInstall 02:54:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Running setup.py install for mozleak 02:54:42 INFO - Running setup.py install for mozlog 02:54:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Running setup.py install for moznetwork 02:54:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Running setup.py install for mozprocess 02:54:42 INFO - Running setup.py install for mozprofile 02:54:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Running setup.py install for mozrunner 02:54:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:54:42 INFO - Running setup.py install for mozscreenshot 02:54:42 INFO - Running setup.py install for moztest 02:54:42 INFO - Running setup.py install for mozversion 02:54:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:54:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:54:43 INFO - Cleaning up... 02:54:43 INFO - Return code: 0 02:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54: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')]} 02:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:43 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:43 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 02:54:43 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 02:54:43 INFO - Using env: {'DISPLAY': ':0', 02:54:43 INFO - 'HOME': '/home/cltbld', 02:54:43 INFO - 'LANG': 'en_US.UTF-8', 02:54:43 INFO - 'LANGUAGE': 'en_US:en', 02:54:43 INFO - 'LOGNAME': 'cltbld', 02:54:43 INFO - 'MAIL': '/var/mail/cltbld', 02:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:43 INFO - 'MOZ_NO_REMOTE': '1', 02:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:43 INFO - 'NO_EM_RESTART': '1', 02:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:43 INFO - 'PWD': '/builds/slave/test', 02:54:43 INFO - 'SHELL': '/bin/bash', 02:54:43 INFO - 'SHLVL': '1', 02:54:43 INFO - 'TERM': 'linux', 02:54:43 INFO - 'TMOUT': '86400', 02:54:43 INFO - 'USER': 'cltbld', 02:54:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:43 INFO - '_': '/tools/buildbot/bin/python'} 02:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:43 INFO - Running setup.py (path:/tmp/pip-ARD3or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:43 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:43 INFO - Running setup.py (path:/tmp/pip-5WDCEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:43 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:43 INFO - Running setup.py (path:/tmp/pip-3h2Xjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:43 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:43 INFO - Running setup.py (path:/tmp/pip-cicQu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:43 INFO - Running setup.py (path:/tmp/pip-BpUuEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:43 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:43 INFO - Running setup.py (path:/tmp/pip-8hW5xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:43 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:43 INFO - Running setup.py (path:/tmp/pip-ncvilD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:43 INFO - Running setup.py (path:/tmp/pip-hS00_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:43 INFO - Running setup.py (path:/tmp/pip-cT1U0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:43 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)) 02:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:43 INFO - Running setup.py (path:/tmp/pip-rrLiUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:44 INFO - Running setup.py (path:/tmp/pip-NzgFzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:44 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:44 INFO - Running setup.py (path:/tmp/pip-feKLo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:44 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:44 INFO - Running setup.py (path:/tmp/pip-oV3dio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:44 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:44 INFO - Running setup.py (path:/tmp/pip-FKCGOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:44 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:44 INFO - Running setup.py (path:/tmp/pip-r9X5Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:44 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:44 INFO - Running setup.py (path:/tmp/pip-EBMwzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:44 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)) 02:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:44 INFO - Running setup.py (path:/tmp/pip-SGnKtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:44 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)) 02:54:44 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)) 02:54:44 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)) 02:54:44 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)) 02:54:44 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:54:44 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:54:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:54:44 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 02:54:44 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 02:54:44 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 02:54:44 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 02:54:45 INFO - Downloading blessings-1.6.tar.gz 02:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:54:45 INFO - Installing collected packages: blessings 02:54:45 INFO - Running setup.py install for blessings 02:54:45 INFO - Successfully installed blessings 02:54:45 INFO - Cleaning up... 02:54:45 INFO - Return code: 0 02:54:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:54:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:46 INFO - Reading from file tmpfile_stdout 02:54:46 INFO - Current package versions: 02:54:46 INFO - argparse == 1.2.1 02:54:46 INFO - blessings == 1.6 02:54:46 INFO - blobuploader == 1.2.4 02:54:46 INFO - docopt == 0.6.1 02:54:46 INFO - functools32 == 3.2.3-2 02:54:46 INFO - jsonschema == 2.5.1 02:54:46 INFO - manifestparser == 1.1 02:54:46 INFO - mozInstall == 1.12 02:54:46 INFO - mozcrash == 1.0 02:54:46 INFO - mozdebug == 0.1 02:54:46 INFO - mozdevice == 0.50 02:54:46 INFO - mozfile == 1.2 02:54:46 INFO - mozhttpd == 0.7 02:54:46 INFO - mozinfo == 0.9 02:54:46 INFO - mozleak == 0.1 02:54:46 INFO - mozlog == 3.4 02:54:46 INFO - moznetwork == 0.27 02:54:46 INFO - mozprocess == 0.25 02:54:46 INFO - mozprofile == 0.28 02:54:46 INFO - mozrunner == 6.13 02:54:46 INFO - mozscreenshot == 0.1 02:54:46 INFO - mozsystemmonitor == 0.3 02:54:46 INFO - moztest == 0.8 02:54:46 INFO - mozversion == 1.4 02:54:46 INFO - psutil == 3.1.1 02:54:46 INFO - requests == 1.2.3 02:54:46 INFO - wsgiref == 0.1.2 02:54:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:46 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:46 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 02:54:46 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 02:54:46 INFO - Using env: {'DISPLAY': ':0', 02:54:46 INFO - 'HOME': '/home/cltbld', 02:54:46 INFO - 'LANG': 'en_US.UTF-8', 02:54:46 INFO - 'LANGUAGE': 'en_US:en', 02:54:46 INFO - 'LOGNAME': 'cltbld', 02:54:46 INFO - 'MAIL': '/var/mail/cltbld', 02:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:46 INFO - 'MOZ_NO_REMOTE': '1', 02:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:46 INFO - 'NO_EM_RESTART': '1', 02:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:46 INFO - 'PWD': '/builds/slave/test', 02:54:46 INFO - 'SHELL': '/bin/bash', 02:54:46 INFO - 'SHLVL': '1', 02:54:46 INFO - 'TERM': 'linux', 02:54:46 INFO - 'TMOUT': '86400', 02:54:46 INFO - 'USER': 'cltbld', 02:54:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:46 INFO - '_': '/tools/buildbot/bin/python'} 02:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 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)) 02:54:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:47 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:54:47 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)) 02:54:47 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)) 02:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:54:47 INFO - Installing collected packages: marionette-driver 02:54:47 INFO - Running setup.py install for marionette-driver 02:54:47 INFO - Successfully installed marionette-driver 02:54:47 INFO - Cleaning up... 02:54:47 INFO - Return code: 0 02:54:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:54:47 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')]} 02:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:47 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')]} 02:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:47 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 0xdbb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, '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': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', '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 02:54:47 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 02:54:47 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 02:54:47 INFO - Using env: {'DISPLAY': ':0', 02:54:47 INFO - 'HOME': '/home/cltbld', 02:54:47 INFO - 'LANG': 'en_US.UTF-8', 02:54:47 INFO - 'LANGUAGE': 'en_US:en', 02:54:47 INFO - 'LOGNAME': 'cltbld', 02:54:47 INFO - 'MAIL': '/var/mail/cltbld', 02:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:47 INFO - 'MOZ_NO_REMOTE': '1', 02:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:47 INFO - 'NO_EM_RESTART': '1', 02:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:47 INFO - 'PWD': '/builds/slave/test', 02:54:47 INFO - 'SHELL': '/bin/bash', 02:54:47 INFO - 'SHLVL': '1', 02:54:47 INFO - 'TERM': 'linux', 02:54:47 INFO - 'TMOUT': '86400', 02:54:47 INFO - 'USER': 'cltbld', 02:54:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:47 INFO - '_': '/tools/buildbot/bin/python'} 02:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:54:47 INFO - Cleaning up... 02:54:47 INFO - Return code: 0 02:54:47 INFO - Running post-action listener: _resource_record_post_action 02:54:47 INFO - Running post-action listener: _start_resource_monitoring 02:54:47 INFO - Starting resource monitoring. 02:54:47 INFO - [mozharness: 2017-05-24 09:54:47.885584Z] Finished create-virtualenv step (success) 02:54:47 INFO - [mozharness: 2017-05-24 09:54:47.886102Z] Running install step. 02:54:47 INFO - Running pre-action listener: _resource_record_pre_action 02:54:47 INFO - Running main action method: install 02:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:48 INFO - Reading from file tmpfile_stdout 02:54:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:54:48 INFO - Reading from file tmpfile_stdout 02:54:48 INFO - Output received: 02:54:48 INFO - Usage: mozinstall [options] installer 02:54:48 INFO - Options: 02:54:48 INFO - -h, --help show this help message and exit 02:54:48 INFO - -d DEST, --destination=DEST 02:54:48 INFO - Directory to install application into. [default: 02:54:48 INFO - "/builds/slave/test"] 02:54:48 INFO - --app=APP Application being installed. [default: firefox] 02:54:48 INFO - mkdir: /builds/slave/test/build/application 02:54:48 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'] 02:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:55:03 INFO - Reading from file tmpfile_stdout 02:55:03 INFO - Output received: 02:55:03 INFO - /builds/slave/test/build/application/firefox/firefox 02:55:03 INFO - Running post-action listener: _resource_record_post_action 02:55:03 INFO - [mozharness: 2017-05-24 09:55:03.915475Z] Finished install step (success) 02:55:03 INFO - [mozharness: 2017-05-24 09:55:03.915751Z] Running run-tests step. 02:55:03 INFO - Running pre-action listener: _resource_record_pre_action 02:55:03 INFO - Running main action method: run_tests 02:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:55:03 INFO - Python 2.7.3 02:55:03 INFO - Return code: 0 02:55:03 INFO - grabbing minidump binary from tooltool 02:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:03 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 0x112b7a0>, '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 0x112c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112cb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:55:03 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 02:55:03 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 02:55:03 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 02:55:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:55:03 INFO - Return code: 0 02:55:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:55:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:55:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:55:03 INFO - ENV: RUST_BACKTRACE is now 1 02:55:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:55:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 02:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 02:55:03 INFO - Using env: {'DISPLAY': ':0', 02:55:03 INFO - 'HOME': '/home/cltbld', 02:55:03 INFO - 'LANG': 'en_US.UTF-8', 02:55:03 INFO - 'LANGUAGE': 'en_US:en', 02:55:04 INFO - 'LOGNAME': 'cltbld', 02:55:04 INFO - 'MAIL': '/var/mail/cltbld', 02:55:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:55:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:04 INFO - 'MOZ_NO_REMOTE': '1', 02:55:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:04 INFO - 'NO_EM_RESTART': '1', 02:55:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:04 INFO - 'PWD': '/builds/slave/test', 02:55:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:55:04 INFO - 'RUST_BACKTRACE': '1', 02:55:04 INFO - 'SHELL': '/bin/bash', 02:55:04 INFO - 'SHLVL': '1', 02:55:04 INFO - 'TERM': 'linux', 02:55:04 INFO - 'TMOUT': '86400', 02:55:04 INFO - 'USER': 'cltbld', 02:55:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922', 02:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:04 INFO - '_': '/tools/buildbot/bin/python'} 02:55:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 02:55:04 INFO - mozversion application_buildid: 20170524092357 02:55:04 INFO - mozversion application_changeset: ffaa07672466b06cd748b07a34cf95377afdde41 02:55:04 INFO - mozversion application_display_name: Nightly 02:55:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:55:04 INFO - mozversion application_name: Firefox 02:55:04 INFO - mozversion application_remotingname: firefox 02:55:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:55:04 INFO - mozversion application_vendor: Mozilla 02:55:04 INFO - mozversion application_version: 55.0a1 02:55:04 INFO - mozversion platform_buildid: 20170524092357 02:55:04 INFO - mozversion platform_changeset: ffaa07672466b06cd748b07a34cf95377afdde41 02:55:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:55:04 INFO - mozversion platform_version: 55.0a1 02:55:04 INFO - using testdate: 1495619704 02:55:04 INFO - actual date: 1495619704 02:55:04 INFO - starting webserver on 'localhost:55525' 02:55:04 INFO - SUITE-START | Running 2 tests 02:55:04 INFO - TEST-START | dromaeo_css 02:55:04 INFO - operating with platform_type : linux_ 02:55:04 INFO - Initialising browser for dromaeo_css test... 02:55:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55525/getInfo.html -profile /tmp/tmp4yVFmF/profile 02:55:04 INFO - TEST-INFO | started process 27529 (/builds/slave/test/build/application/firefox/firefox http://localhost:55525/getInfo.html) 02:55:39 INFO - TEST-INFO | 27529: killed by SIGTERM 02:55:39 INFO - Browser initialized. 02:55:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:55:39 INFO - TEST-INFO | started process 27728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yVFmF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:51 INFO - PID 27728 | RSS: Main: 174616576 02:55:51 INFO - PID 27728 | 02:58:55 INFO - PID 27728 | Cycle 1(1): loaded http://localhost:55525/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55525/tests/dromaeo/cssquery-ext.html) 02:58:57 INFO - PID 27728 | RSS: Main: 174096384 02:58:57 INFO - PID 27728 | 03:01:59 INFO - PID 27728 | Cycle 1(1): loaded http://localhost:55525/tests/dromaeo/cssquery-ext.html (next: http://localhost:55525/tests/dromaeo/cssquery-jquery.html) 03:01:59 INFO - PID 27728 | RSS: Main: 176578560 03:01:59 INFO - PID 27728 | 03:05:01 INFO - PID 27728 | Cycle 1(1): loaded http://localhost:55525/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55525/tests/dromaeo/cssquery-mootools.html) 03:05:02 INFO - PID 27728 | RSS: Main: 174981120 03:05:02 INFO - PID 27728 | 03:08:03 INFO - PID 27728 | Cycle 1(1): loaded http://localhost:55525/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55525/tests/dromaeo/cssquery-prototype.html) 03:08:04 INFO - PID 27728 | RSS: Main: 178032640 03:08:04 INFO - PID 27728 | 03:11:07 INFO - PID 27728 | Cycle 1(1): loaded http://localhost:55525/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55525/tests/dromaeo/cssquery-yui.html) 03:11:07 INFO - PID 27728 | RSS: Main: 177500160 03:11:07 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | Cycle 1(1): loaded http://localhost:55525/tests/dromaeo/cssquery-yui.html (next: http://localhost:55525/tests/dromaeo/cssquery-dojo.html) 03:14:09 INFO - PID 27728 | RSS: Main: 176463872 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | __start_tp_report 03:14:09 INFO - PID 27728 | _x_x_mozilla_page_load 03:14:09 INFO - PID 27728 | _x_x_mozilla_page_load_details 03:14:09 INFO - PID 27728 | |i|pagename|runs| 03:14:09 INFO - PID 27728 | |0;dojo.html;2634;2664.5203863304596;2671.933201669958;2681.9061332853353;2697.0964726816514;5059.418166910807;5067.391912970439;5098.566621837143;5120.103981803179;5143.614228932831;5107.923381149286;5127.948720512793;5148.330717006784;5201.037808005522;5223.895522089556;4608.792604332813;4610.054938737568;4629.467611224702;4657.441107067149;4679.27471241958;4643.210654188796;4667.8599642010795;4679.438467383919;4705.082848633851;4753.47711751707;4536.954630453686;4600.17196904557;4639.814407423699;4643.071385722869;4718.41019872516;4573.885652858705;4599.080183963188;4599.540045995407;4643.791029403685;4647.767611619405;4584.610308123813;4597.241455159895;4604.539546045402;4604.94812450119;4623.491415944243;5024.221245706921;5078.085944529983;5166.844994650167;5172.922406163911;5173.793048278064;5435.483629055233;5501.119820828648;5509.421510741355;5537;5537.944620553783;5633.492985631272;5650.26546548946;5650.265465489501;5654.858628534278;5668.4614961579;5015.398152221756;5229.111051121318;5247.842564723064;5261.342332208474;5294.205869119586;5632.774689012475;5639.8590035249445;5659.6321239119325;5672.837068400968;5693.516051135617;5426.104692725656;5433.782648694008;5517.089680202802;5527.44725527444;5529.972350138223;5508.779648814083;5514.641548299348;5524.447555244444;5526.253955716007;5536.7231638418725;5349.81275655358;5465.480779325958;5471.835844924579;5491.505764481216;5546.694931778791;5397.109476936262;5470.452954704578;5508.421615730371;5610.551155907518;5628.690422026746;4687.062587482517;4695.577398034194;4699.083678682692;4730.739809310521;4736.64475164364;4007.8396864125693;4011.217812526529;4012.29784787661;4024.0744628735556;4049;4593.655475839326;4651.674382793172;4718.693284936468;4783.904321913542;4787.353707249476;5599.244102046172;5659.745311460994;5668.971655141698;5678.517326027334;5691.430856914276;4759.286107083965;4759.452662943737;4762.642801789811;4762.904741905142;4812.230043193073;4952.851414457572;4997.275395067695;4998.500149984972;5004.224345226496;5026.623003274769;4979.9004019918675;5061.089003979172;5157.6647517911215;5179.637425380187;5200.713960732045;5495.972520137374;5652.293463317085;5662.320521537277;5675.262215911905;5702.714864256687;5126.487351264844;5140.280360749423;5176.870578235575;5231.3722353316325;5239.790408383622;5406.053940560465;5523.972380138073;5525;5526.751296191601;5528.9723551381985;5422.240886275846;5532.0595498766115;5617.634853734494;5632.5212356950115;5636.436356364331;5402.054640437829;5448.073827449422;5474.178873169057;5520.227168196536;5523.751431185526;5494.230807686847;5496.917546236729;5512.531434827924;5525.834224973257;5538.224648549126;5348.705821179872;5406.540444062299;5412.107002344569;5415.458454154711;5446.564274858081;5470.206820011155;5502.284702988746;5511.283533140666;5527;5548.556115510669;5162.922556161736;5237.869053273698;5279.52484276417;5303.098473259633;5416.485433883775 03:14:09 INFO - PID 27728 | |1;ext.html;633.2717375018727;687.4259992905924;701.074581552351;1149.666596686961;1201.051169576035;33762.324753504916;34245.31509369811;34333.31333373334;34342.48486272708;34406.139846503786;33316.66683333166;33608.159796005115;33732.831335843344;33739.83130084346;33798.66201337986;6327.651979141146;6456.483481321483;6526.347365263483;6742.528023038365;6752.594844309333;6643.93356066438;6702.262751097375;6713.093732346119;6740.730370785162;6764.289749576297;6716.126903502538;6782.525223234351;6792.694328755193;6806.4554835613035;6809.931900680979;6707.899381509281;6716.0933274007875;6733.25934147241;6738.764143255012;6756.223034351064;6696.698648560827;6697.598144111369;6754.8311292217595;6776.356246156607;6778.966105169492;31734;31867.840660796548;31929;31954.840225798955;32197.35605287881;3055.9847200764075;3096.5819614352;3098.90703278902;3100.457419951522;3102.395032968572;24191.75808241913;24285.271441856774;24360.147394841097;24405.26784196477;24430.87784561066;3034.8027378220345;3040.6351237851377;3044.0563425338214;3056.2970516781043;3100.90697279082;144261;144819;145606;151613.24193379073;154879;38744.612553874664;38941;39025.804870975466;39059.21881562353;39149.23828427728;40413.59586404157;40420.393694094615;40583.59416405857;40787.7960610201;42796;12165.452554635063;12214.450349734283;12266.938665306616;12288.447019884126;12320.137590368768;9669.661561845302;9690.321677482509;9735.513224338754;9768.90231097694;9794.951025244829;12694.301813400167;12726.23642581448;12776.425060872283;12806.67983300425;12935.676608084685;5295.417504074549;5315.793945512569;5409.675419474844;5419.783208671688;5443.836684899459;880.859062549989;916.9128932751378;928.475411392561;928.6285485805597;955.2262667239419;19834.50413739668;20634.17463301451;21354.57290854174;21580.244691436037;21688.13247470115;976.2629214942673;977.8044391121804;985.4383001688968;1007.4156988946394;1010.3937637417491;10979.505922233519;11267.38029408374;11370.54517819278;11389.37358445277;11533.596324128615;174799;175804;176916;177068;177593;39490.60509394927;39625.40561891574;39640.60359396369;39645.80177099096;39729.801350993635;1176.5559613942642;1224.865264820869;1229.213303485752;1229.5204870100667;1233.2600439736266;19208;19861.205551777766;20171;20796;20800;28890.133296001153;35669.28661426809;36607.63392366149;36629.63370366262;36662.450063249606;165416;167092;167375;167437.11658742142;167568;30378.696213037587;30401.391972160876;30644.71783284466;30683;30785.383242424647;35681;35736.28527429489;36413.817930910176;36417.81791091028;36526.17369131586;27644.308892277855;28061.57907631428;28110.43779124447;28135.296617584725;28978.855105724335;26834;27309.453810924068;27383.726162738916;27550.862245688644;28564.14307570776;30597;30921.226969325948;30946.84526577353;31125.221869453446;31143;26351.73648263493;26551.468970620866;27036.45927081408;27585.310367240978;27935.301617459725;21224.7877521229;22180.66728999034;22335.77664223337;22434.663480047486;22521.324360269216 03:14:09 INFO - PID 27728 | |2;jquery.html;409.12651489070845;409.206140088229;418.109426920659;437.48595400404514;444.8309642335912;13954.930225348884;14717.411303547846;17162.3135074597;18144.364947226848;18192.454226373215;18544.165512551936;18656;19028.2388704452;19046.904765476153;19303;5170.8707282318055;5285.577153827704;5334.893302133955;5374.247605335257;5514.117741161395;5236.345456817879;5246.422893481714;5250.474952504738;5259.447757985414;5297.735113244342;4996.225585034325;5200.115980283361;5282.973585132069;5334.066538355792;5359.30329057222;5327.227552004957;5349.919751203715;5383.43473935235;5402.91895621566;5411.972940135313;4784.497627749106;4895;4934.259861020875;4947.208446648519;4947.332110165117;21942.561148776935;22161.55676886453;22762.317130485946;22770.65844012341;22905.770942290696;1589.6741168060519;1652.017049855334;1652.2317122537956;1659.5768079139864;1664.96670066598;14161.150330980174;14474.493392731203;14569.490067847575;14740.852591474162;14792;1965.3514340267677;2028.78697736737;2036.5112373030515;2055.9486012849648;2070.637638413287;88311.55844220801;97942.51028744882;98206.5089674547;98397;100875.49562252215;17923.910380448015;17972.281108755502;18022.36921707734;18404.723929141073;18486.630267394576;35061.47407788885;35128.29743405118;35221.29557408838;35573.1106722334;35644;8975.326850486239;8985.326100542485;9066.682666106655;9093.272538196929;9320.347575669639;7201.243869393743;7234.674439650228;7372.373348265458;7393.593352365671;7435.628218589049;9097.406524422817;9665.468399237969;9708.757281067888;9810.264230182765;9822.754431139136;3804.505414296124;3843.7693738375788;3847.4228865670375;3876.205377897524;3923.293807114747;820.2248874813245;873.7335112790532;881.4402854187637;882.3117967984982;888.7511496780912;16996.830031699526;17173.7423938641;17298;17469.388571400195;17959;885.7431344910033;889.8487257166297;895.3777124898133;898.0974121008476;899.8628257887517;9211.861822072675;9623.422594644344;9668.564914578861;9682.467464289532;9764.609415623296;354074;355475;357588;357826;360518;74704;78977;79033;79989.20010799934;81294.59352703199;1035.1460045462522;1041.5573381313063;1069.8555694981078;1072.8068947589352;1074.1245884604023;14578.125312481285;14794;15030.323635436212;15042.473513426978;15530.9223453882;37806.62193378031;38196.80901595474;38263.61736382601;38609.80695096619;39030.80484597672;47426;47877;47895;47917.28124078211;48795.26807097825;11335.263207891461;11825.231359961575;12094.697632559257;12137.817932731192;12241.510339586317;13234.602961911158;13276.402561884544;13285.867141328463;13581.253031083384;13874.236916969663;11123.610673626385;11206.943965280121;11520.366379849189;11628.127890408423;11775.587854425054;10435.58257669715;10436.425996570262;10585.523651435858;10627.89372106269;10716.839247411139;11479.770404591694;11533.308001519936;11871.465784039912;11961.581344652895;12053.397330133283;11844.407779610812;11943.343116128697;11971.940140299592;12099.153059285765;12447.875521244672;11497.195196336175;11574.884251157717;11766.117541184274;11988.700282493008;12062.396880156133 03:14:09 INFO - PID 27728 | |3;mootools.html;1237.344207569988;1290.9160904541204;1302.6873550347907;1303.133416278175;1317.2557505009668;9837.262205334602;10377.792444151122;10387.740306492333;10411.427371494565;10775.730606734836;10447.216458765584;10608.681739547827;10687;10690.679279621605;10698.625548105818;2229.4314949687846;2280.749117597063;2282.417983414227;2299.4596269876565;2310.595645761993;2078.5738923520644;2127.617028934791;2132.9146834126695;2139.4330502416874;2143.3891340967825;2179.9019044142974;2205.9779402206013;2225.9109635614554;2236.39617303328;2238.955220895581;2132.7166441832014;2165.72928383952;2220.8001279884807;2223.899924503401;2230.3754948614414;2098.748150221983;2118.9087619875777;2124.5326028273753;2126.3727200475896;2203.933881983543;10220.74448138795;10223.335483193569;10253.43606101664;10297.279190456671;10301.896981030168;5618.803341883015;5807.622504537191;5808.244928159313;5810.738516766755;5838.649681019152;3301.3067255876294;3405.080628230389;3457.567804024497;3563.002359339389;3581.4448760442174;1046.4558429616634;1054.1777413617315;1069.5347523827081;1115.8047341715248;1135.721748171695;14889.70220595582;15010.549683509513;15038.248087595686;15041.699166016619;15066;4627.329037289574;4716.316134160596;4969.3539839821315;4990.2764099205415;5024.522670346384;10816.4050977197;10825.945870270598;10828.242023058468;10840.945795270973;10878.075363594025;5649.887002259932;5673.8297851064535;5676.943230567724;5700.828975130753;5702.6863522506665;4950.851474455772;5087.898242035212;5182.404023537341;5258.6581872178185;5276.577873770089;3749;3885.941710874339;3906.55074666417;3955.110100227426;3966;1108.706192858893;1110.5002748763088;1115.5426275227119;1119.1326721790676;1127.9887201128047;712.3019440947796;726.8001299642641;738.6085374751391;741.6884908338511;742.9517081389693;5594.13290939905;5652.943470565242;5670.177824215466;5699.572532060112;5725.971370143123;535.5046581911716;561.9072852979212;562.5415286541455;562.6202313438413;567.1662655895826;3471.704905083096;3980.900477488028;4006.859759908389;4012;4125.380383456467;12178.269303841798;12531;13031.674208144872;13396.799048014287;13485.595432137052;12408.503659853684;12531.498740050296;12574.43415046325;12665.620031399072;12685.302308373128;7163.10461192351;7273.563586184846;7331;7340.265973402617;7418.740344088039;5774.249347584787;5836.591438599257;5838.12428135783;5918.319393269829;6066.4540191382985;11267.661970140909;11322.207445479067;11377.374244416305;11411.828822567502;11461.083113350745;11407.25852819564;11508.88491115078;11566.595169169039;11673.766524669629;11846.289222646668;7339.339459448675;7453.217412171643;7460.850782984418;7463.552186868588;7469.925300746923;9153.725388238363;9178.311626628163;9243.306751993492;9247.630094796134;9346.439213647203;7599.696012159673;7619.123800762762;7676.309132178131;7683.231676832272;7695.846083078419;7468.738594149178;7509.924900751141;7560.58416787082;7565.848683026419;7589.506682065648;6579.539432239697;6681.398674119353;6689.732410703517;6721.260661327152;6723.663816809042;4754.97622511899;5056.393232812086;5100.9489905101955;5158.845234642967;5365.356157261153;5135.87160320995;5140.820071297487;5177.508136727005;5200.557952573922;5387.649802762808 03:14:09 INFO - PID 27728 | |4;prototype.html;370.2373111390536;383.07487417885807;385.7242071918578;391.60839160839157;396.5142700192264;5282.788688452457;5380.5426538744205;5447.400785913546;5458.2904222451125;5463.879904619554;5251.343582052244;5322.7644389356465;5330.933813237349;5339.733013349336;5343.1985202219685;4037.7981100944908;4083.4487344208596;4090.7750073745933;4093.570175131613;4111.805957922917;3929.1552316252;4091.529474110471;4095.1604920991126;4096.528899176603;4099.836006559749;4043.029672878503;4055.9797201013953;4057.310257256259;4059.269331520325;4065.8170382332864;4044.2113787811095;4048.6356227939627;4054.959450405517;4056.3915412688184;4062.878113656595;3557.62644922282;3567.839447224881;3569.678728914384;3573.714102871764;3573.94639080414;5049.722265275408;5144.353806781832;5163.277141200235;5177.249298851683;5177.58579313654;4698.765061746899;4729.43246810385;4756.167670657621;4769.308450274691;4769.618430525549;5516.282883225155;5586;5626.099824028136;5638.689872057035;5649.887002259973;3934.6065393460713;3937.310970580137;3962.86129985452;3967.2858885400615;3968.980155099206;5826.455989162875;5926.318473375574;6012.518998480155;6040.909386359208;6048.485878700316;4453.977730111394;4525.864224073283;4543;4546.976930190747;4555.863324100283;4621.4223222097235;4624.699394539344;4631.768411579407;4636.142313671981;4643.721376717408;4968.329275547827;5051.217061355495;5051.772670229849;5073.746312684351;5077.974610126999;5659.349174844863;5699.401562835926;5699.658020518782;5703.287089113861;5723.456271654186;1566.0994927916493;1580.6996670632543;1584.128729198936;1587.2857214253631;1587.4761328761713;1107.6542001468256;1143.6397534776518;1158.6408213453856;1159.5767544846071;1171.6291938432055;4792.95207047932;4812.326274321597;4856.39295088114;4870.342503761947;4874.46380898101;5839.620424672467;5846.473817356458;5907.379725128885;5908.822735317947;5926;4688.929666055012;4839.249916262985;4904.6321525885705;4911.582515486152;4916.950830491721;3069.6009518762417;3096.993477119945;3102.348506813594;3109.362580670957;3115.704008119225;5311.681299122065;5315.255864179018;5367.463253674601;5400.729963501809;5404.162354835007;5957.672328022;5958.85102872423;6002.818506191726;6008.879822403527;6010.969945150334;5360.517553420211;5399.379071406838;5400.729963501888;5416.377116631559;5416.485433883775;5748.45389687979;5827;5834.708264586839;5898.64608123514;5900.822975310747;5603.411641777555;5758.767306029981;5778.439821248156;5797.362290148165;5810.571762659882;5384.515393614593;5388.54197393226;5423.4034256231;5436.266104075899;5438.483344082306;4033.979830100831;4066.898327541835;4082.265192265302;4099.815508302074;4100.261952848516;5760.222369979999;5787.826365209051;5873.236479257669;5914.172015917861;5956.285245770535;5675.57433192504;5701.372848986525;5714.685692286798;5718.942810571841;5735.655860648374;5684.488396044376;5694.316681998187;5696.772129114955;5708.743106560131;5731.254936858182;5501.807436739695;5604.635698679573;5629.718514074362;5660.698039450867;5667.574931880208;5741.45456181662;5761.308642962871;5776.537876969916;5782.034108403163;5782.2483077199695;5502.9174562380795;5546;5551.444855514416;5579.330480342385;5607.747651355618 03:14:09 INFO - PID 27728 | |5;yui.html;700.7127077898062;704.6230266807257;720.6937051753004;748.1359030319983;769.9615019249036;12370.319632420213;12948;13021.479140834366;15449.5365139046;15932.84067159328;14670.413183472674;15112.244387780622;15187.6962460751;15195.164265965395;16245.350185992545;882.7440042387716;898.2679116520015;899.163777686751;901.0358915959926;907.1563445995222;904.0597778310549;905.814308066848;906.619219927632;909.6225066597387;910.7313342563926;940.3323640215456;941.750436134425;942.1379437814426;942.6417961174744;945.6170251048336;945.1399226703701;946.7964387656687;947.3321308477541;947.7962238118769;948.2698322291797;687.3092541995263;693.660106547793;694.2467422846217;694.9027136200936;697.3723648716145;13463.86536134636;13844.238566878817;14148.363323650461;14217.431302747878;14218.146911185362;15669.608259793482;15719.214039297989;16014.919925400414;16129.274182661808;16132.435364762177;12510.3744812759;12626.81059784104;12674.493020279178;12699.682507937376;12836.743265134644;2990.626171728534;3015.9396812063856;3020.7885448018646;3023.833689147096;3031.9090427287215;69096.30903691;69138.3086169137;69216.6539167306;69291.65354173248;69443.99999999949;9402.294827887936;13116.278604676643;13148.671283217996;13151.868481315065;13183.14309569875;20968.895155524126;22735.658965115537;22889.427764306027;22973.885130574574;23017;5807;6014.398560144038;6052.969735151384;6091.177691011745;6483.675816209171;2831.759300459443;2845.8007939444456;2884.206843118159;2886.3505711214807;2890.8410037448143;3360.495925611178;3416.6754158354915;3430.1939044324563;3460.2560449502976;3460.2560449503476;627.6861569215392;630.3412933484428;631.0502693446425;633.3697970519363;633.6293268438016;532.4170033812968;535.1090434426636;540.6242661350324;550.0692569082549;555.8110242517563;8596.527191004554;8824.338174636929;9072;9181.495017774087;9391.812163756687;537.3605409562608;558.1153871114329;564.5145175149369;565.7595521903174;569.8262030080865;3763.717721170923;3788.2234142000825;3809.5999920008;3809.638084382035;3847.9230415391535;63328.683356583846;64663.353366466676;65155.674221628586;65788;65834.34165658378;55954.44045559492;56839.43160568424;57536.136957945666;57910.7104464475;60811;52261.2160817588;52768.208476872875;52894.20658690123;53303.46696532985;53844;7413.888791668021;7516.962415187889;7541.35898448638;7569.659365328684;7624.428167887541;25391;25694.229173124837;26805;26879.328016799736;27214.319642009108;42024.15951680888;42198.367024494044;43532.56467435285;43915.56084439115;45611;13684.110532815335;13799;13808.309584520533;13882.652933676738;14032.929835351166;14610.634734131732;14698;15190;15346.616334591725;15359.769603455734;13567.79648305296;14101.083429577455;14168.079074860101;14304.570862873714;14472.421103156177;12586.748265034465;13077.934610326887;13761.243131627856;13793.172409655454;13848.238346891017;13416.39003319608;13694.794578081137;14199.077059991068;14413.13521188732;14900.329485172977;9546.331756777237;9738.513074346396;9880.25898057663;9964.10323070927;10275.126614237874;10856.402897840379;10917.181211409335;11125.888741112485;11442.370669612917;11723.765524689628 03:14:09 INFO - PID 27728 | __end_tp_report 03:14:09 INFO - PID 27728 | __start_cc_report 03:14:09 INFO - PID 27728 | _x_x_mozilla_cycle_collect,345 03:14:09 INFO - PID 27728 | __end_cc_report 03:14:09 INFO - PID 27728 | __startTimestamp1495620849820__endTimestamp 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | ------- Summary: start ------- 03:14:09 INFO - PID 27728 | Number of tests: 6 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | [#0] dojo.html Cycles:165 Average:5100.04 Median:5237.87 stddev:597.29 (11.4%) stddev-sans-first:566.93 03:14:09 INFO - PID 27728 | Values: 2634.0 2664.5 2671.9 2681.9 2697.1 5059.4 5067.4 5098.6 5120.1 5143.6 5107.9 5127.9 5148.3 5201.0 5223.9 4608.8 4610.1 4629.5 4657.4 4679.3 4643.2 4667.9 4679.4 4705.1 4753.5 4537.0 4600.2 4639.8 4643.1 4718.4 4573.9 4599.1 4599.5 4643.8 4647.8 4584.6 4597.2 4604.5 4604.9 4623.5 5024.2 5078.1 5166.8 5172.9 5173.8 5435.5 5501.1 5509.4 5537.0 5537.9 5633.5 5650.3 5650.3 5654.9 5668.5 5015.4 5229.1 5247.8 5261.3 5294.2 5632.8 5639.9 5659.6 5672.8 5693.5 5426.1 5433.8 5517.1 5527.4 5530.0 5508.8 5514.6 5524.4 5526.3 5536.7 5349.8 5465.5 5471.8 5491.5 5546.7 5397.1 5470.5 5508.4 5610.6 5628.7 4687.1 4695.6 4699.1 4730.7 4736.6 4007.8 4011.2 4012.3 4024.1 4049.0 4593.7 4651.7 4718.7 4783.9 4787.4 5599.2 5659.7 5669.0 5678.5 5691.4 4759.3 4759.5 4762.6 4762.9 4812.2 4952.9 4997.3 4998.5 5004.2 5026.6 4979.9 5061.1 5157.7 5179.6 5200.7 5496.0 5652.3 5662.3 5675.3 5702.7 5126.5 5140.3 5176.9 5231.4 5239.8 5406.1 5524.0 5525.0 5526.8 5529.0 5422.2 5532.1 5617.6 5632.5 5636.4 5402.1 5448.1 5474.2 5520.2 5523.8 5494.2 5496.9 5512.5 5525.8 5538.2 5348.7 5406.5 5412.1 5415.5 5446.6 5470.2 5502.3 5511.3 5527.0 5548.6 5162.9 5237.9 5279.5 5303.1 5416.5 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | [#1] ext.html Cycles:180 Average:30811.88 Median:3100.68 stddev:42406.79 (1367.7%) stddev-sans-first:42465.21 03:14:09 INFO - PID 27728 | Values: 633.3 687.4 701.1 1149.7 1201.1 33762.3 34245.3 34333.3 34342.5 34406.1 33316.7 33608.2 33732.8 33739.8 33798.7 6327.7 6456.5 6526.3 6742.5 6752.6 6643.9 6702.3 6713.1 6740.7 6764.3 6716.1 6782.5 6792.7 6806.5 6809.9 6707.9 6716.1 6733.3 6738.8 6756.2 6696.7 6697.6 6754.8 6776.4 6779.0 31734.0 31867.8 31929.0 31954.8 32197.4 3056.0 3096.6 3098.9 3100.5 3102.4 24191.8 24285.3 24360.1 24405.3 24430.9 3034.8 3040.6 3044.1 3056.3 3100.9 144261.0 144819.0 145606.0 151613.2 154879.0 38744.6 38941.0 39025.8 39059.2 39149.2 40413.6 40420.4 40583.6 40787.8 42796.0 12165.5 12214.5 12266.9 12288.4 12320.1 9669.7 9690.3 9735.5 9768.9 9795.0 12694.3 12726.2 12776.4 12806.7 12935.7 5295.4 5315.8 5409.7 5419.8 5443.8 880.9 916.9 928.5 928.6 955.2 19834.5 20634.2 21354.6 21580.2 21688.1 976.3 977.8 985.4 1007.4 1010.4 10979.5 11267.4 11370.5 11389.4 11533.6 174799.0 175804.0 176916.0 177068.0 177593.0 39490.6 39625.4 39640.6 39645.8 39729.8 1176.6 1224.9 1229.2 1229.5 1233.3 19208.0 19861.2 20171.0 20796.0 20800.0 28890.1 35669.3 36607.6 36629.6 36662.5 165416.0 167092.0 167375.0 167437.1 167568.0 30378.7 30401.4 30644.7 30683.0 30785.4 35681.0 35736.3 36413.8 36417.8 36526.2 27644.3 28061.6 28110.4 28135.3 28978.9 26834.0 27309.5 27383.7 27550.9 28564.1 30597.0 30921.2 30946.8 31125.2 31143.0 26351.7 26551.5 27036.5 27585.3 27935.3 21224.8 22180.7 22335.8 22434.7 22521.3 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | [#2] jquery.html Cycles:180 Average:25910.95 Median:195524.06 stddev:59712.43 (30.5%) stddev-sans-first:59849.24 03:14:09 INFO - PID 27728 | Values: 409.1 409.2 418.1 437.5 444.8 13954.9 14717.4 17162.3 18144.4 18192.5 18544.2 18656.0 19028.2 19046.9 19303.0 5170.9 5285.6 5334.9 5374.2 5514.1 5236.3 5246.4 5250.5 5259.4 5297.7 4996.2 5200.1 5283.0 5334.1 5359.3 5327.2 5349.9 5383.4 5402.9 5412.0 4784.5 4895.0 4934.3 4947.2 4947.3 21942.6 22161.6 22762.3 22770.7 22905.8 1589.7 1652.0 1652.2 1659.6 1665.0 14161.2 14474.5 14569.5 14740.9 14792.0 1965.4 2028.8 2036.5 2055.9 2070.6 88311.6 97942.5 98206.5 98397.0 100875.5 17923.9 17972.3 18022.4 18404.7 18486.6 35061.5 35128.3 35221.3 35573.1 35644.0 8975.3 8985.3 9066.7 9093.3 9320.3 7201.2 7234.7 7372.4 7393.6 7435.6 9097.4 9665.5 9708.8 9810.3 9822.8 3804.5 3843.8 3847.4 3876.2 3923.3 820.2 873.7 881.4 882.3 888.8 16996.8 17173.7 17298.0 17469.4 17959.0 885.7 889.8 895.4 898.1 899.9 9211.9 9623.4 9668.6 9682.5 9764.6 354074.0 355475.0 357588.0 357826.0 360518.0 74704.0 78977.0 79033.0 79989.2 81294.6 1035.1 1041.6 1069.9 1072.8 1074.1 14578.1 14794.0 15030.3 15042.5 15530.9 37806.6 38196.8 38263.6 38609.8 39030.8 47426.0 47877.0 47895.0 47917.3 48795.3 11335.3 11825.2 12094.7 12137.8 12241.5 13234.6 13276.4 13285.9 13581.3 13874.2 11123.6 11206.9 11520.4 11628.1 11775.6 10435.6 10436.4 10585.5 10627.9 10716.8 11479.8 11533.3 11871.5 11961.6 12053.4 11844.4 11943.3 11971.9 12099.2 12447.9 11497.2 11574.9 11766.1 11988.7 12062.4 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | [#3] mootools.html Cycles:180 Average:6159.41 Median:3817.47 stddev:3930.34 (103.0%) stddev-sans-first:3923.97 03:14:09 INFO - PID 27728 | Values: 1237.3 1290.9 1302.7 1303.1 1317.3 9837.3 10377.8 10387.7 10411.4 10775.7 10447.2 10608.7 10687.0 10690.7 10698.6 2229.4 2280.7 2282.4 2299.5 2310.6 2078.6 2127.6 2132.9 2139.4 2143.4 2179.9 2206.0 2225.9 2236.4 2239.0 2132.7 2165.7 2220.8 2223.9 2230.4 2098.7 2118.9 2124.5 2126.4 2203.9 10220.7 10223.3 10253.4 10297.3 10301.9 5618.8 5807.6 5808.2 5810.7 5838.6 3301.3 3405.1 3457.6 3563.0 3581.4 1046.5 1054.2 1069.5 1115.8 1135.7 14889.7 15010.5 15038.2 15041.7 15066.0 4627.3 4716.3 4969.4 4990.3 5024.5 10816.4 10825.9 10828.2 10840.9 10878.1 5649.9 5673.8 5676.9 5700.8 5702.7 4950.9 5087.9 5182.4 5258.7 5276.6 3749.0 3885.9 3906.6 3955.1 3966.0 1108.7 1110.5 1115.5 1119.1 1128.0 712.3 726.8 738.6 741.7 743.0 5594.1 5652.9 5670.2 5699.6 5726.0 535.5 561.9 562.5 562.6 567.2 3471.7 3980.9 4006.9 4012.0 4125.4 12178.3 12531.0 13031.7 13396.8 13485.6 12408.5 12531.5 12574.4 12665.6 12685.3 7163.1 7273.6 7331.0 7340.3 7418.7 5774.2 5836.6 5838.1 5918.3 6066.5 11267.7 11322.2 11377.4 11411.8 11461.1 11407.3 11508.9 11566.6 11673.8 11846.3 7339.3 7453.2 7460.9 7463.6 7469.9 9153.7 9178.3 9243.3 9247.6 9346.4 7599.7 7619.1 7676.3 7683.2 7695.8 7468.7 7509.9 7560.6 7565.8 7589.5 6579.5 6681.4 6689.7 6721.3 6723.7 4755.0 5056.4 5100.9 5158.8 5365.4 5135.9 5140.8 5177.5 5200.6 5387.6 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | [#4] prototype.html Cycles:180 Average:4713.72 Median:5267.07 stddev:1348.52 (25.6%) stddev-sans-first:1312.31 03:14:09 INFO - PID 27728 | Values: 370.2 383.1 385.7 391.6 396.5 5282.8 5380.5 5447.4 5458.3 5463.9 5251.3 5322.8 5330.9 5339.7 5343.2 4037.8 4083.4 4090.8 4093.6 4111.8 3929.2 4091.5 4095.2 4096.5 4099.8 4043.0 4056.0 4057.3 4059.3 4065.8 4044.2 4048.6 4055.0 4056.4 4062.9 3557.6 3567.8 3569.7 3573.7 3573.9 5049.7 5144.4 5163.3 5177.2 5177.6 4698.8 4729.4 4756.2 4769.3 4769.6 5516.3 5586.0 5626.1 5638.7 5649.9 3934.6 3937.3 3962.9 3967.3 3969.0 5826.5 5926.3 6012.5 6040.9 6048.5 4454.0 4525.9 4543.0 4547.0 4555.9 4621.4 4624.7 4631.8 4636.1 4643.7 4968.3 5051.2 5051.8 5073.7 5078.0 5659.3 5699.4 5699.7 5703.3 5723.5 1566.1 1580.7 1584.1 1587.3 1587.5 1107.7 1143.6 1158.6 1159.6 1171.6 4793.0 4812.3 4856.4 4870.3 4874.5 5839.6 5846.5 5907.4 5908.8 5926.0 4688.9 4839.2 4904.6 4911.6 4917.0 3069.6 3097.0 3102.3 3109.4 3115.7 5311.7 5315.3 5367.5 5400.7 5404.2 5957.7 5958.9 6002.8 6008.9 6011.0 5360.5 5399.4 5400.7 5416.4 5416.5 5748.5 5827.0 5834.7 5898.6 5900.8 5603.4 5758.8 5778.4 5797.4 5810.6 5384.5 5388.5 5423.4 5436.3 5438.5 4034.0 4066.9 4082.3 4099.8 4100.3 5760.2 5787.8 5873.2 5914.2 5956.3 5675.6 5701.4 5714.7 5718.9 5735.7 5684.5 5694.3 5696.8 5708.7 5731.3 5501.8 5604.6 5629.7 5660.7 5667.6 5741.5 5761.3 5776.5 5782.0 5782.2 5502.9 5546.0 5551.4 5579.3 5607.7 03:14:09 INFO - PID 27728 | 03:14:09 INFO - PID 27728 | [#5] yui.html Cycles:180 Average:15439.77 Median:42111.26 stddev:18553.73 (44.1%) stddev-sans-first:18572.76 03:14:09 INFO - PID 27728 | Values: 700.7 704.6 720.7 748.1 770.0 12370.3 12948.0 13021.5 15449.5 15932.8 14670.4 15112.2 15187.7 15195.2 16245.4 882.7 898.3 899.2 901.0 907.2 904.1 905.8 906.6 909.6 910.7 940.3 941.8 942.1 942.6 945.6 945.1 946.8 947.3 947.8 948.3 687.3 693.7 694.2 694.9 697.4 13463.9 13844.2 14148.4 14217.4 14218.1 15669.6 15719.2 16014.9 16129.3 16132.4 12510.4 12626.8 12674.5 12699.7 12836.7 2990.6 3015.9 3020.8 3023.8 3031.9 69096.3 69138.3 69216.7 69291.7 69444.0 9402.3 13116.3 13148.7 13151.9 13183.1 20968.9 22735.7 22889.4 22973.9 23017.0 5807.0 6014.4 6053.0 6091.2 6483.7 2831.8 2845.8 2884.2 2886.4 2890.8 3360.5 3416.7 3430.2 3460.3 3460.3 627.7 630.3 631.1 633.4 633.6 532.4 535.1 540.6 550.1 555.8 8596.5 8824.3 9072.0 9181.5 9391.8 537.4 558.1 564.5 565.8 569.8 3763.7 3788.2 3809.6 3809.6 3847.9 63328.7 64663.4 65155.7 65788.0 65834.3 55954.4 56839.4 57536.1 57910.7 60811.0 52261.2 52768.2 52894.2 53303.5 53844.0 7413.9 7517.0 7541.4 7569.7 7624.4 25391.0 25694.2 26805.0 26879.3 27214.3 42024.2 42198.4 43532.6 43915.6 45611.0 13684.1 13799.0 13808.3 13882.7 14032.9 14610.6 14698.0 15190.0 15346.6 15359.8 13567.8 14101.1 14168.1 14304.6 14472.4 12586.7 13077.9 13761.2 13793.2 13848.2 13416.4 13694.8 14199.1 14413.1 14900.3 9546.3 9738.5 9880.3 9964.1 10275.1 10856.4 10917.2 11125.9 11442.4 11723.8 03:14:09 INFO - PID 27728 | -------- Summary: end -------- 03:14:09 INFO - PID 27728 | 03:14:10 INFO - TEST-INFO | 27728: exit 0 03:14:10 INFO - TEST-OK | dromaeo_css | took 1146483ms 03:14:10 INFO - TEST-START | kraken 03:14:10 INFO - operating with platform_type : linux_ 03:14:10 INFO - Initialising browser for kraken test... 03:14:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55525/getInfo.html -profile /tmp/tmpA2L0f8/profile 03:14:10 INFO - TEST-INFO | started process 28135 (/builds/slave/test/build/application/firefox/firefox http://localhost:55525/getInfo.html) 03:14:45 INFO - TEST-INFO | 28135: killed by SIGTERM 03:14:45 INFO - Browser initialized. 03:14:45 INFO - Running cycle 1/1 for kraken test... 03:14:45 INFO - TEST-INFO | started process 28333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA2L0f8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:57 INFO - PID 28333 | RSS: Main: 174211072 03:14:57 INFO - PID 28333 | 03:15:00 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55525/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:01 INFO - PID 28333 | RSS: Main: 179871744 03:15:01 INFO - PID 28333 | 03:15:04 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55525/tests/kraken/driver.html?testName=audio-dft) 03:15:04 INFO - PID 28333 | RSS: Main: 178593792 03:15:04 INFO - PID 28333 | 03:15:07 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55525/tests/kraken/driver.html?testName=audio-fft) 03:15:08 INFO - PID 28333 | RSS: Main: 175931392 03:15:08 INFO - PID 28333 | 03:15:10 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55525/tests/kraken/driver.html?testName=audio-oscillator) 03:15:11 INFO - PID 28333 | RSS: Main: 176492544 03:15:11 INFO - PID 28333 | 03:15:13 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55525/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:13 INFO - PID 28333 | RSS: Main: 176590848 03:15:13 INFO - PID 28333 | 03:15:17 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55525/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:17 INFO - PID 28333 | RSS: Main: 178085888 03:15:17 INFO - PID 28333 | 03:15:21 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55525/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:21 INFO - PID 28333 | RSS: Main: 177360896 03:15:21 INFO - PID 28333 | 03:15:24 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55525/tests/kraken/driver.html?testName=json-parse-financial) 03:15:25 INFO - PID 28333 | RSS: Main: 178245632 03:15:25 INFO - PID 28333 | 03:15:26 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55525/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:27 INFO - PID 28333 | RSS: Main: 178515968 03:15:27 INFO - PID 28333 | 03:15:29 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:30 INFO - PID 28333 | RSS: Main: 178040832 03:15:30 INFO - PID 28333 | 03:15:32 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:33 INFO - PID 28333 | RSS: Main: 178118656 03:15:33 INFO - PID 28333 | 03:15:35 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:15:36 INFO - PID 28333 | RSS: Main: 178122752 03:15:36 INFO - PID 28333 | 03:15:39 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:15:40 INFO - PID 28333 | RSS: Main: 178073600 03:15:40 INFO - PID 28333 | 03:15:41 INFO - PID 28333 | Cycle 1(1): loaded http://localhost:55525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55525/tests/kraken/driver.html?testName=ai-astar) 03:15:42 INFO - PID 28333 | RSS: Main: 179560448 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | __start_tp_report 03:15:42 INFO - PID 28333 | _x_x_mozilla_page_load 03:15:42 INFO - PID 28333 | _x_x_mozilla_page_load_details 03:15:42 INFO - PID 28333 | |i|pagename|runs| 03:15:42 INFO - PID 28333 | |0;ai-astar;105;112;113;112;112;113;113;112;114;113 03:15:42 INFO - PID 28333 | |1;audio-beat-detection;146;128;129;175;123;125;124;123;146;125 03:15:42 INFO - PID 28333 | |2;audio-dft;165;163;162;165;169;170;166;167;163;162 03:15:42 INFO - PID 28333 | |3;audio-fft;73;73;75;110;75;77;75;76;101;76 03:15:42 INFO - PID 28333 | |4;audio-oscillator;84;83;106;83;84;86;97;84;84;108 03:15:42 INFO - PID 28333 | |5;imaging-gaussian-blur;114;116;114;115;115;114;115;116;114;115 03:15:42 INFO - PID 28333 | |6;imaging-darkroom;152;152;150;153;151;152;151;151;151;150 03:15:42 INFO - PID 28333 | |7;imaging-desaturate;95;96;94;95;96;95;94;95;95;95 03:15:42 INFO - PID 28333 | |8;json-parse-financial;54;54;54;55;55;56;53;56;55;55 03:15:42 INFO - PID 28333 | |9;json-stringify-tinderbox;56;57;56;56;56;57;56;57;56;57 03:15:42 INFO - PID 28333 | |10;stanford-crypto-aes;87;89;87;90;90;89;88;88;123;87 03:15:42 INFO - PID 28333 | |11;stanford-crypto-ccm;140;138;133;132;144;140;142;136;143;137 03:15:42 INFO - PID 28333 | |12;stanford-crypto-pbkdf2;188;194;200;199;194;198;196;191;195;193 03:15:42 INFO - PID 28333 | |13;stanford-crypto-sha256-iterative;76;74;74;74;72;72;72;74;71;73 03:15:42 INFO - PID 28333 | __end_tp_report 03:15:42 INFO - PID 28333 | __start_cc_report 03:15:42 INFO - PID 28333 | _x_x_mozilla_cycle_collect,937 03:15:42 INFO - PID 28333 | __end_cc_report 03:15:42 INFO - PID 28333 | __startTimestamp1495620942210__endTimestamp 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | ------- Summary: start ------- 03:15:42 INFO - PID 28333 | Number of tests: 14 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.51 (2.2%) stddev-sans-first:0.71 03:15:42 INFO - PID 28333 | Values: 105.0 112.0 113.0 112.0 112.0 113.0 113.0 112.0 114.0 113.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:128.50 stddev:16.77 (13.1%) stddev-sans-first:17.26 03:15:42 INFO - PID 28333 | Values: 146.0 128.0 129.0 175.0 123.0 125.0 124.0 123.0 146.0 125.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:2.82 (1.7%) stddev-sans-first:2.99 03:15:42 INFO - PID 28333 | Values: 165.0 163.0 162.0 165.0 169.0 170.0 166.0 167.0 163.0 162.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.09 (17.5%) stddev-sans-first:13.56 03:15:42 INFO - PID 28333 | Values: 73.0 73.0 75.0 110.0 75.0 77.0 75.0 76.0 101.0 76.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:9.93 (11.8%) stddev-sans-first:10.30 03:15:42 INFO - PID 28333 | Values: 84.0 83.0 106.0 83.0 84.0 86.0 97.0 84.0 84.0 108.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 03:15:42 INFO - PID 28333 | Values: 114.0 116.0 114.0 115.0 115.0 114.0 115.0 116.0 114.0 115.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 03:15:42 INFO - PID 28333 | Values: 152.0 152.0 150.0 153.0 151.0 152.0 151.0 151.0 151.0 150.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:15:42 INFO - PID 28333 | Values: 95.0 96.0 94.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.97 03:15:42 INFO - PID 28333 | Values: 54.0 54.0 54.0 55.0 55.0 56.0 53.0 56.0 55.0 55.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 03:15:42 INFO - PID 28333 | Values: 56.0 57.0 56.0 56.0 56.0 57.0 56.0 57.0 56.0 57.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:88.50 stddev:11.02 (12.5%) stddev-sans-first:11.55 03:15:42 INFO - PID 28333 | Values: 87.0 89.0 87.0 90.0 90.0 89.0 88.0 88.0 123.0 87.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:140.00 stddev:4.06 (2.9%) stddev-sans-first:4.27 03:15:42 INFO - PID 28333 | Values: 140.0 138.0 133.0 132.0 144.0 140.0 142.0 136.0 143.0 137.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.80 Median:195.50 stddev:3.68 (1.9%) stddev-sans-first:2.96 03:15:42 INFO - PID 28333 | Values: 188.0 194.0 200.0 199.0 194.0 198.0 196.0 191.0 195.0 193.0 03:15:42 INFO - PID 28333 | 03:15:42 INFO - PID 28333 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:1.48 (2.0%) stddev-sans-first:1.17 03:15:42 INFO - PID 28333 | Values: 76.0 74.0 74.0 74.0 72.0 72.0 72.0 74.0 71.0 73.0 03:15:42 INFO - PID 28333 | -------- Summary: end -------- 03:15:42 INFO - PID 28333 | 03:15:43 INFO - TEST-INFO | 28333: exit 0 03:15:43 INFO - TEST-OK | kraken | took 92551ms 03:15:43 INFO - SUITE-END | took 1239s 03:15:43 INFO - Completed test suite (00:20:39) 03:15:43 INFO - javascript benchmark 03:15:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6755.840392621507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.0, 2664.5203863304596, 2671.933201669958, 2681.9061332853353, 2697.0964726816514, 5059.418166910807, 5067.391912970439, 5098.566621837143, 5120.103981803179, 5143.614228932831, 5107.923381149286, 5127.948720512793, 5148.330717006784, 5201.037808005522, 5223.895522089556, 4608.792604332813, 4610.054938737568, 4629.467611224702, 4657.441107067149, 4679.27471241958, 4643.210654188796, 4667.8599642010795, 4679.438467383919, 4705.082848633851, 4753.47711751707, 4536.954630453686, 4600.17196904557, 4639.814407423699, 4643.071385722869, 4718.41019872516, 4573.885652858705, 4599.080183963188, 4599.540045995407, 4643.791029403685, 4647.767611619405, 4584.610308123813, 4597.241455159895, 4604.539546045402, 4604.94812450119, 4623.491415944243, 5024.221245706921, 5078.085944529983, 5166.844994650167, 5172.922406163911, 5173.793048278064, 5435.483629055233, 5501.119820828648, 5509.421510741355, 5537.0, 5537.944620553783, 5633.492985631272, 5650.26546548946, 5650.265465489501, 5654.858628534278, 5668.4614961579, 5015.398152221756, 5229.111051121318, 5247.842564723064, 5261.342332208474, 5294.205869119586, 5632.774689012475, 5639.8590035249445, 5659.6321239119325, 5672.837068400968, 5693.516051135617, 5426.104692725656, 5433.782648694008, 5517.089680202802, 5527.44725527444, 5529.972350138223, 5508.779648814083, 5514.641548299348, 5524.447555244444, 5526.253955716007, 5536.7231638418725, 5349.81275655358, 5465.480779325958, 5471.835844924579, 5491.505764481216, 5546.694931778791, 5397.109476936262, 5470.452954704578, 5508.421615730371, 5610.551155907518, 5628.690422026746, 4687.062587482517, 4695.577398034194, 4699.083678682692, 4730.739809310521, 4736.64475164364, 4007.8396864125693, 4011.217812526529, 4012.29784787661, 4024.0744628735556, 4049.0, 4593.655475839326, 4651.674382793172, 4718.693284936468, 4783.904321913542, 4787.353707249476, 5599.244102046172, 5659.745311460994, 5668.971655141698, 5678.517326027334, 5691.430856914276, 4759.286107083965, 4759.452662943737, 4762.642801789811, 4762.904741905142, 4812.230043193073, 4952.851414457572, 4997.275395067695, 4998.500149984972, 5004.224345226496, 5026.623003274769, 4979.9004019918675, 5061.089003979172, 5157.6647517911215, 5179.637425380187, 5200.713960732045, 5495.972520137374, 5652.293463317085, 5662.320521537277, 5675.262215911905, 5702.714864256687, 5126.487351264844, 5140.280360749423, 5176.870578235575, 5231.3722353316325, 5239.790408383622, 5406.053940560465, 5523.972380138073, 5525.0, 5526.751296191601, 5528.9723551381985, 5422.240886275846, 5532.0595498766115, 5617.634853734494, 5632.5212356950115, 5636.436356364331, 5402.054640437829, 5448.073827449422, 5474.178873169057, 5520.227168196536, 5523.751431185526, 5494.230807686847, 5496.917546236729, 5512.531434827924, 5525.834224973257, 5538.224648549126, 5348.705821179872, 5406.540444062299, 5412.107002344569, 5415.458454154711, 5446.564274858081, 5470.206820011155, 5502.284702988746, 5511.283533140666, 5527.0, 5548.556115510669, 5162.922556161736, 5237.869053273698, 5279.52484276417, 5303.098473259633, 5416.485433883775], "value": 5056.528588283244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.2717375018727, 687.4259992905924, 701.074581552351, 1149.666596686961, 1201.051169576035, 33762.324753504916, 34245.31509369811, 34333.31333373334, 34342.48486272708, 34406.139846503786, 33316.66683333166, 33608.159796005115, 33732.831335843344, 33739.83130084346, 33798.66201337986, 6327.651979141146, 6456.483481321483, 6526.347365263483, 6742.528023038365, 6752.594844309333, 6643.93356066438, 6702.262751097375, 6713.093732346119, 6740.730370785162, 6764.289749576297, 6716.126903502538, 6782.525223234351, 6792.694328755193, 6806.4554835613035, 6809.931900680979, 6707.899381509281, 6716.0933274007875, 6733.25934147241, 6738.764143255012, 6756.223034351064, 6696.698648560827, 6697.598144111369, 6754.8311292217595, 6776.356246156607, 6778.966105169492, 31734.0, 31867.840660796548, 31929.0, 31954.840225798955, 32197.35605287881, 3055.9847200764075, 3096.5819614352, 3098.90703278902, 3100.457419951522, 3102.395032968572, 24191.75808241913, 24285.271441856774, 24360.147394841097, 24405.26784196477, 24430.87784561066, 3034.8027378220345, 3040.6351237851377, 3044.0563425338214, 3056.2970516781043, 3100.90697279082, 144261.0, 144819.0, 145606.0, 151613.24193379073, 154879.0, 38744.612553874664, 38941.0, 39025.804870975466, 39059.21881562353, 39149.23828427728, 40413.59586404157, 40420.393694094615, 40583.59416405857, 40787.7960610201, 42796.0, 12165.452554635063, 12214.450349734283, 12266.938665306616, 12288.447019884126, 12320.137590368768, 9669.661561845302, 9690.321677482509, 9735.513224338754, 9768.90231097694, 9794.951025244829, 12694.301813400167, 12726.23642581448, 12776.425060872283, 12806.67983300425, 12935.676608084685, 5295.417504074549, 5315.793945512569, 5409.675419474844, 5419.783208671688, 5443.836684899459, 880.859062549989, 916.9128932751378, 928.475411392561, 928.6285485805597, 955.2262667239419, 19834.50413739668, 20634.17463301451, 21354.57290854174, 21580.244691436037, 21688.13247470115, 976.2629214942673, 977.8044391121804, 985.4383001688968, 1007.4156988946394, 1010.3937637417491, 10979.505922233519, 11267.38029408374, 11370.54517819278, 11389.37358445277, 11533.596324128615, 174799.0, 175804.0, 176916.0, 177068.0, 177593.0, 39490.60509394927, 39625.40561891574, 39640.60359396369, 39645.80177099096, 39729.801350993635, 1176.5559613942642, 1224.865264820869, 1229.213303485752, 1229.5204870100667, 1233.2600439736266, 19208.0, 19861.205551777766, 20171.0, 20796.0, 20800.0, 28890.133296001153, 35669.28661426809, 36607.63392366149, 36629.63370366262, 36662.450063249606, 165416.0, 167092.0, 167375.0, 167437.11658742142, 167568.0, 30378.696213037587, 30401.391972160876, 30644.71783284466, 30683.0, 30785.383242424647, 35681.0, 35736.28527429489, 36413.817930910176, 36417.81791091028, 36526.17369131586, 27644.308892277855, 28061.57907631428, 28110.43779124447, 28135.296617584725, 28978.855105724335, 26834.0, 27309.453810924068, 27383.726162738916, 27550.862245688644, 28564.14307570776, 30597.0, 30921.226969325948, 30946.84526577353, 31125.221869453446, 31143.0, 26351.73648263493, 26551.468970620866, 27036.45927081408, 27585.310367240978, 27935.301617459725, 21224.7877521229, 22180.66728999034, 22335.77664223337, 22434.663480047486, 22521.324360269216], "value": 14519.369332116703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.12651489070845, 409.206140088229, 418.109426920659, 437.48595400404514, 444.8309642335912, 13954.930225348884, 14717.411303547846, 17162.3135074597, 18144.364947226848, 18192.454226373215, 18544.165512551936, 18656.0, 19028.2388704452, 19046.904765476153, 19303.0, 5170.8707282318055, 5285.577153827704, 5334.893302133955, 5374.247605335257, 5514.117741161395, 5236.345456817879, 5246.422893481714, 5250.474952504738, 5259.447757985414, 5297.735113244342, 4996.225585034325, 5200.115980283361, 5282.973585132069, 5334.066538355792, 5359.30329057222, 5327.227552004957, 5349.919751203715, 5383.43473935235, 5402.91895621566, 5411.972940135313, 4784.497627749106, 4895.0, 4934.259861020875, 4947.208446648519, 4947.332110165117, 21942.561148776935, 22161.55676886453, 22762.317130485946, 22770.65844012341, 22905.770942290696, 1589.6741168060519, 1652.017049855334, 1652.2317122537956, 1659.5768079139864, 1664.96670066598, 14161.150330980174, 14474.493392731203, 14569.490067847575, 14740.852591474162, 14792.0, 1965.3514340267677, 2028.78697736737, 2036.5112373030515, 2055.9486012849648, 2070.637638413287, 88311.55844220801, 97942.51028744882, 98206.5089674547, 98397.0, 100875.49562252215, 17923.910380448015, 17972.281108755502, 18022.36921707734, 18404.723929141073, 18486.630267394576, 35061.47407788885, 35128.29743405118, 35221.29557408838, 35573.1106722334, 35644.0, 8975.326850486239, 8985.326100542485, 9066.682666106655, 9093.272538196929, 9320.347575669639, 7201.243869393743, 7234.674439650228, 7372.373348265458, 7393.593352365671, 7435.628218589049, 9097.406524422817, 9665.468399237969, 9708.757281067888, 9810.264230182765, 9822.754431139136, 3804.505414296124, 3843.7693738375788, 3847.4228865670375, 3876.205377897524, 3923.293807114747, 820.2248874813245, 873.7335112790532, 881.4402854187637, 882.3117967984982, 888.7511496780912, 16996.830031699526, 17173.7423938641, 17298.0, 17469.388571400195, 17959.0, 885.7431344910033, 889.8487257166297, 895.3777124898133, 898.0974121008476, 899.8628257887517, 9211.861822072675, 9623.422594644344, 9668.564914578861, 9682.467464289532, 9764.609415623296, 354074.0, 355475.0, 357588.0, 357826.0, 360518.0, 74704.0, 78977.0, 79033.0, 79989.20010799934, 81294.59352703199, 1035.1460045462522, 1041.5573381313063, 1069.8555694981078, 1072.8068947589352, 1074.1245884604023, 14578.125312481285, 14794.0, 15030.323635436212, 15042.473513426978, 15530.9223453882, 37806.62193378031, 38196.80901595474, 38263.61736382601, 38609.80695096619, 39030.80484597672, 47426.0, 47877.0, 47895.0, 47917.28124078211, 48795.26807097825, 11335.263207891461, 11825.231359961575, 12094.697632559257, 12137.817932731192, 12241.510339586317, 13234.602961911158, 13276.402561884544, 13285.867141328463, 13581.253031083384, 13874.236916969663, 11123.610673626385, 11206.943965280121, 11520.366379849189, 11628.127890408423, 11775.587854425054, 10435.58257669715, 10436.425996570262, 10585.523651435858, 10627.89372106269, 10716.839247411139, 11479.770404591694, 11533.308001519936, 11871.465784039912, 11961.581344652895, 12053.397330133283, 11844.407779610812, 11943.343116128697, 11971.940140299592, 12099.153059285765, 12447.875521244672, 11497.195196336175, 11574.884251157717, 11766.117541184274, 11988.700282493008, 12062.396880156133], "value": 9668.845110672273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.344207569988, 1290.9160904541204, 1302.6873550347907, 1303.133416278175, 1317.2557505009668, 9837.262205334602, 10377.792444151122, 10387.740306492333, 10411.427371494565, 10775.730606734836, 10447.216458765584, 10608.681739547827, 10687.0, 10690.679279621605, 10698.625548105818, 2229.4314949687846, 2280.749117597063, 2282.417983414227, 2299.4596269876565, 2310.595645761993, 2078.5738923520644, 2127.617028934791, 2132.9146834126695, 2139.4330502416874, 2143.3891340967825, 2179.9019044142974, 2205.9779402206013, 2225.9109635614554, 2236.39617303328, 2238.955220895581, 2132.7166441832014, 2165.72928383952, 2220.8001279884807, 2223.899924503401, 2230.3754948614414, 2098.748150221983, 2118.9087619875777, 2124.5326028273753, 2126.3727200475896, 2203.933881983543, 10220.74448138795, 10223.335483193569, 10253.43606101664, 10297.279190456671, 10301.896981030168, 5618.803341883015, 5807.622504537191, 5808.244928159313, 5810.738516766755, 5838.649681019152, 3301.3067255876294, 3405.080628230389, 3457.567804024497, 3563.002359339389, 3581.4448760442174, 1046.4558429616634, 1054.1777413617315, 1069.5347523827081, 1115.8047341715248, 1135.721748171695, 14889.70220595582, 15010.549683509513, 15038.248087595686, 15041.699166016619, 15066.0, 4627.329037289574, 4716.316134160596, 4969.3539839821315, 4990.2764099205415, 5024.522670346384, 10816.4050977197, 10825.945870270598, 10828.242023058468, 10840.945795270973, 10878.075363594025, 5649.887002259932, 5673.8297851064535, 5676.943230567724, 5700.828975130753, 5702.6863522506665, 4950.851474455772, 5087.898242035212, 5182.404023537341, 5258.6581872178185, 5276.577873770089, 3749.0, 3885.941710874339, 3906.55074666417, 3955.110100227426, 3966.0, 1108.706192858893, 1110.5002748763088, 1115.5426275227119, 1119.1326721790676, 1127.9887201128047, 712.3019440947796, 726.8001299642641, 738.6085374751391, 741.6884908338511, 742.9517081389693, 5594.13290939905, 5652.943470565242, 5670.177824215466, 5699.572532060112, 5725.971370143123, 535.5046581911716, 561.9072852979212, 562.5415286541455, 562.6202313438413, 567.1662655895826, 3471.704905083096, 3980.900477488028, 4006.859759908389, 4012.0, 4125.380383456467, 12178.269303841798, 12531.0, 13031.674208144872, 13396.799048014287, 13485.595432137052, 12408.503659853684, 12531.498740050296, 12574.43415046325, 12665.620031399072, 12685.302308373128, 7163.10461192351, 7273.563586184846, 7331.0, 7340.265973402617, 7418.740344088039, 5774.249347584787, 5836.591438599257, 5838.12428135783, 5918.319393269829, 6066.4540191382985, 11267.661970140909, 11322.207445479067, 11377.374244416305, 11411.828822567502, 11461.083113350745, 11407.25852819564, 11508.88491115078, 11566.595169169039, 11673.766524669629, 11846.289222646668, 7339.339459448675, 7453.217412171643, 7460.850782984418, 7463.552186868588, 7469.925300746923, 9153.725388238363, 9178.311626628163, 9243.306751993492, 9247.630094796134, 9346.439213647203, 7599.696012159673, 7619.123800762762, 7676.309132178131, 7683.231676832272, 7695.846083078419, 7468.738594149178, 7509.924900751141, 7560.58416787082, 7565.848683026419, 7589.506682065648, 6579.539432239697, 6681.398674119353, 6689.732410703517, 6721.260661327152, 6723.663816809042, 4754.97622511899, 5056.393232812086, 5100.9489905101955, 5158.845234642967, 5365.356157261153, 5135.87160320995, 5140.820071297487, 5177.508136727005, 5200.557952573922, 5387.649802762808], "value": 4634.044698067952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2373111390536, 383.07487417885807, 385.7242071918578, 391.60839160839157, 396.5142700192264, 5282.788688452457, 5380.5426538744205, 5447.400785913546, 5458.2904222451125, 5463.879904619554, 5251.343582052244, 5322.7644389356465, 5330.933813237349, 5339.733013349336, 5343.1985202219685, 4037.7981100944908, 4083.4487344208596, 4090.7750073745933, 4093.570175131613, 4111.805957922917, 3929.1552316252, 4091.529474110471, 4095.1604920991126, 4096.528899176603, 4099.836006559749, 4043.029672878503, 4055.9797201013953, 4057.310257256259, 4059.269331520325, 4065.8170382332864, 4044.2113787811095, 4048.6356227939627, 4054.959450405517, 4056.3915412688184, 4062.878113656595, 3557.62644922282, 3567.839447224881, 3569.678728914384, 3573.714102871764, 3573.94639080414, 5049.722265275408, 5144.353806781832, 5163.277141200235, 5177.249298851683, 5177.58579313654, 4698.765061746899, 4729.43246810385, 4756.167670657621, 4769.308450274691, 4769.618430525549, 5516.282883225155, 5586.0, 5626.099824028136, 5638.689872057035, 5649.887002259973, 3934.6065393460713, 3937.310970580137, 3962.86129985452, 3967.2858885400615, 3968.980155099206, 5826.455989162875, 5926.318473375574, 6012.518998480155, 6040.909386359208, 6048.485878700316, 4453.977730111394, 4525.864224073283, 4543.0, 4546.976930190747, 4555.863324100283, 4621.4223222097235, 4624.699394539344, 4631.768411579407, 4636.142313671981, 4643.721376717408, 4968.329275547827, 5051.217061355495, 5051.772670229849, 5073.746312684351, 5077.974610126999, 5659.349174844863, 5699.401562835926, 5699.658020518782, 5703.287089113861, 5723.456271654186, 1566.0994927916493, 1580.6996670632543, 1584.128729198936, 1587.2857214253631, 1587.4761328761713, 1107.6542001468256, 1143.6397534776518, 1158.6408213453856, 1159.5767544846071, 1171.6291938432055, 4792.95207047932, 4812.326274321597, 4856.39295088114, 4870.342503761947, 4874.46380898101, 5839.620424672467, 5846.473817356458, 5907.379725128885, 5908.822735317947, 5926.0, 4688.929666055012, 4839.249916262985, 4904.6321525885705, 4911.582515486152, 4916.950830491721, 3069.6009518762417, 3096.993477119945, 3102.348506813594, 3109.362580670957, 3115.704008119225, 5311.681299122065, 5315.255864179018, 5367.463253674601, 5400.729963501809, 5404.162354835007, 5957.672328022, 5958.85102872423, 6002.818506191726, 6008.879822403527, 6010.969945150334, 5360.517553420211, 5399.379071406838, 5400.729963501888, 5416.377116631559, 5416.485433883775, 5748.45389687979, 5827.0, 5834.708264586839, 5898.64608123514, 5900.822975310747, 5603.411641777555, 5758.767306029981, 5778.439821248156, 5797.362290148165, 5810.571762659882, 5384.515393614593, 5388.54197393226, 5423.4034256231, 5436.266104075899, 5438.483344082306, 4033.979830100831, 4066.898327541835, 4082.265192265302, 4099.815508302074, 4100.261952848516, 5760.222369979999, 5787.826365209051, 5873.236479257669, 5914.172015917861, 5956.285245770535, 5675.57433192504, 5701.372848986525, 5714.685692286798, 5718.942810571841, 5735.655860648374, 5684.488396044376, 5694.316681998187, 5696.772129114955, 5708.743106560131, 5731.254936858182, 5501.807436739695, 5604.635698679573, 5629.718514074362, 5660.698039450867, 5667.574931880208, 5741.45456181662, 5761.308642962871, 5776.537876969916, 5782.034108403163, 5782.2483077199695, 5502.9174562380795, 5546.0, 5551.444855514416, 5579.330480342385, 5607.747651355618], "value": 4314.622137766258, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7127077898062, 704.6230266807257, 720.6937051753004, 748.1359030319983, 769.9615019249036, 12370.319632420213, 12948.0, 13021.479140834366, 15449.5365139046, 15932.84067159328, 14670.413183472674, 15112.244387780622, 15187.6962460751, 15195.164265965395, 16245.350185992545, 882.7440042387716, 898.2679116520015, 899.163777686751, 901.0358915959926, 907.1563445995222, 904.0597778310549, 905.814308066848, 906.619219927632, 909.6225066597387, 910.7313342563926, 940.3323640215456, 941.750436134425, 942.1379437814426, 942.6417961174744, 945.6170251048336, 945.1399226703701, 946.7964387656687, 947.3321308477541, 947.7962238118769, 948.2698322291797, 687.3092541995263, 693.660106547793, 694.2467422846217, 694.9027136200936, 697.3723648716145, 13463.86536134636, 13844.238566878817, 14148.363323650461, 14217.431302747878, 14218.146911185362, 15669.608259793482, 15719.214039297989, 16014.919925400414, 16129.274182661808, 16132.435364762177, 12510.3744812759, 12626.81059784104, 12674.493020279178, 12699.682507937376, 12836.743265134644, 2990.626171728534, 3015.9396812063856, 3020.7885448018646, 3023.833689147096, 3031.9090427287215, 69096.30903691, 69138.3086169137, 69216.6539167306, 69291.65354173248, 69443.99999999949, 9402.294827887936, 13116.278604676643, 13148.671283217996, 13151.868481315065, 13183.14309569875, 20968.895155524126, 22735.658965115537, 22889.427764306027, 22973.885130574574, 23017.0, 5807.0, 6014.398560144038, 6052.969735151384, 6091.177691011745, 6483.675816209171, 2831.759300459443, 2845.8007939444456, 2884.206843118159, 2886.3505711214807, 2890.8410037448143, 3360.495925611178, 3416.6754158354915, 3430.1939044324563, 3460.2560449502976, 3460.2560449503476, 627.6861569215392, 630.3412933484428, 631.0502693446425, 633.3697970519363, 633.6293268438016, 532.4170033812968, 535.1090434426636, 540.6242661350324, 550.0692569082549, 555.8110242517563, 8596.527191004554, 8824.338174636929, 9072.0, 9181.495017774087, 9391.812163756687, 537.3605409562608, 558.1153871114329, 564.5145175149369, 565.7595521903174, 569.8262030080865, 3763.717721170923, 3788.2234142000825, 3809.5999920008, 3809.638084382035, 3847.9230415391535, 63328.683356583846, 64663.353366466676, 65155.674221628586, 65788.0, 65834.34165658378, 55954.44045559492, 56839.43160568424, 57536.136957945666, 57910.7104464475, 60811.0, 52261.2160817588, 52768.208476872875, 52894.20658690123, 53303.46696532985, 53844.0, 7413.888791668021, 7516.962415187889, 7541.35898448638, 7569.659365328684, 7624.428167887541, 25391.0, 25694.229173124837, 26805.0, 26879.328016799736, 27214.319642009108, 42024.15951680888, 42198.367024494044, 43532.56467435285, 43915.56084439115, 45611.0, 13684.110532815335, 13799.0, 13808.309584520533, 13882.652933676738, 14032.929835351166, 14610.634734131732, 14698.0, 15190.0, 15346.616334591725, 15359.769603455734, 13567.79648305296, 14101.083429577455, 14168.079074860101, 14304.570862873714, 14472.421103156177, 12586.748265034465, 13077.934610326887, 13761.243131627856, 13793.172409655454, 13848.238346891017, 13416.39003319608, 13694.794578081137, 14199.077059991068, 14413.13521188732, 14900.329485172977, 9546.331756777237, 9738.513074346396, 9880.25898057663, 9964.10323070927, 10275.126614237874, 10856.402897840379, 10917.181211409335, 11125.888741112485, 11442.370669612917, 11723.765524689628], "value": 6698.294905331801, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 114.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 129.0, 175.0, 123.0, 125.0, 124.0, 123.0, 146.0, 125.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 165.0, 169.0, 170.0, 166.0, 167.0, 163.0, 162.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 110.0, 75.0, 77.0, 75.0, 76.0, 101.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 106.0, 83.0, 84.0, 86.0, 97.0, 84.0, 84.0, 108.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 115.0, 115.0, 114.0, 115.0, 116.0, 114.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 153.0, 151.0, 152.0, 151.0, 151.0, 151.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 56.0, 53.0, 56.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 87.0, 90.0, 90.0, 89.0, 88.0, 88.0, 123.0, 87.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 133.0, 132.0, 144.0, 140.0, 142.0, 136.0, 143.0, 137.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 194.0, 200.0, 199.0, 194.0, 198.0, 196.0, 191.0, 195.0, 193.0], "value": 194.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 74.0, 72.0, 72.0, 72.0, 74.0, 71.0, 73.0], "value": 73.2, "unit": "score"}]}]} 03:15:43 INFO - Return code: 0 03:15:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:15:43 INFO - # TBPL SUCCESS # 03:15:43 INFO - Running post-action listener: _resource_record_post_action 03:15:43 INFO - [mozharness: 2017-05-24 10:15:43.514291Z] Finished run-tests step (success) 03:15:43 INFO - Running post-run listener: _resource_record_post_run 03:15:43 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 12288; Write bytes: 401047552; Read time: 68; Write time: 281704 03:15:43 INFO - TinderboxPrint: CPU usage
12.7% 03:15:43 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 68 03:15:43 INFO - TinderboxPrint: I/O write bytes / time
401,047,552 / 281,704 03:15:43 INFO - TinderboxPrint: CPU idle
8,736.7 (87.3%) 03:15:43 INFO - TinderboxPrint: CPU user
1,218.5 (12.2%) 03:15:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:15:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98275328; Read time: 40; Write time: 81324 03:15:43 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302772224; Read time: 16; Write time: 200380 03:15:44 INFO - Running post-run listener: _upload_blobber_files 03:15:44 INFO - Blob upload gear active. 03:15:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:15:44 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 03:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:15:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:15:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:50 INFO - (blobuploader) - INFO - Done attempting. 03:15:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:15:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:15:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:51 INFO - (blobuploader) - INFO - Done attempting. 03:15:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:15:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:52 INFO - (blobuploader) - INFO - Done attempting. 03:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:15:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:53 INFO - (blobuploader) - INFO - Done attempting. 03:15:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:15:53 INFO - Return code: 0 03:15:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:15:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:15:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f9de8b9ba5c253121a8d549035d979313a55da9d5e00233c872b41eeb824e859c3eeb9277185c59b5dcf2f145bc5341bbc609d1c1e5ac60ab800fa17127062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9a66d2f0c66f1c2c569b9879c2b4601384c5af7bd7b629804a54fc1677ee6582913635ce79fa3d2ee5f446ff49708967eb1a3ba9170db706d8c60c989f98720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af91c461c75dce073a2f86261dfa917183cad8ea0f0a48b15dc14e7c96104bf2817cee8a95220ff5ebece62fca7873442ea09131c56e7fa2de945d1ca9d7673f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c560a9c58e36be9398fce7c7e087f5ba7236905f49a8161d7314b15fff1f437b3473dc8f80bf428d1f2407b72f33a362cb4c7cada09dd4e1807b1e41f393e91"} 03:15:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:15:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:15:53 INFO - Contents: 03:15:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f9de8b9ba5c253121a8d549035d979313a55da9d5e00233c872b41eeb824e859c3eeb9277185c59b5dcf2f145bc5341bbc609d1c1e5ac60ab800fa17127062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9a66d2f0c66f1c2c569b9879c2b4601384c5af7bd7b629804a54fc1677ee6582913635ce79fa3d2ee5f446ff49708967eb1a3ba9170db706d8c60c989f98720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af91c461c75dce073a2f86261dfa917183cad8ea0f0a48b15dc14e7c96104bf2817cee8a95220ff5ebece62fca7873442ea09131c56e7fa2de945d1ca9d7673f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c560a9c58e36be9398fce7c7e087f5ba7236905f49a8161d7314b15fff1f437b3473dc8f80bf428d1f2407b72f33a362cb4c7cada09dd4e1807b1e41f393e91"} 03:15:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:15:53 INFO - Copying logs to upload dir... 03:15:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:15:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.583299 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-24 03:15:53.141405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 03:15:53.146328) ========= 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=eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f9de8b9ba5c253121a8d549035d979313a55da9d5e00233c872b41eeb824e859c3eeb9277185c59b5dcf2f145bc5341bbc609d1c1e5ac60ab800fa17127062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9a66d2f0c66f1c2c569b9879c2b4601384c5af7bd7b629804a54fc1677ee6582913635ce79fa3d2ee5f446ff49708967eb1a3ba9170db706d8c60c989f98720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af91c461c75dce073a2f86261dfa917183cad8ea0f0a48b15dc14e7c96104bf2817cee8a95220ff5ebece62fca7873442ea09131c56e7fa2de945d1ca9d7673f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c560a9c58e36be9398fce7c7e087f5ba7236905f49a8161d7314b15fff1f437b3473dc8f80bf428d1f2407b72f33a362cb4c7cada09dd4e1807b1e41f393e91"} build_url:https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/J_x_erhcTjyJTsobOHq_8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f9de8b9ba5c253121a8d549035d979313a55da9d5e00233c872b41eeb824e859c3eeb9277185c59b5dcf2f145bc5341bbc609d1c1e5ac60ab800fa17127062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9a66d2f0c66f1c2c569b9879c2b4601384c5af7bd7b629804a54fc1677ee6582913635ce79fa3d2ee5f446ff49708967eb1a3ba9170db706d8c60c989f98720", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af91c461c75dce073a2f86261dfa917183cad8ea0f0a48b15dc14e7c96104bf2817cee8a95220ff5ebece62fca7873442ea09131c56e7fa2de945d1ca9d7673f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c560a9c58e36be9398fce7c7e087f5ba7236905f49a8161d7314b15fff1f437b3473dc8f80bf428d1f2407b72f33a362cb4c7cada09dd4e1807b1e41f393e91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 03:15:53.169873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 03:15:53.173192) ========= 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=eca2ab57546de7b41f256b19000001ef-1495619635.981973-510813922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 03:15:53.255533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 03:15:53.255826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 03:15:53.257204) ========= ========= Total master_lag: 0.18 =========