builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1495452414.84 results: success (0) revision: b4a8c54c2b056a5df90bf2284a25c4bec75bb1be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:54.845004) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:54.845470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:54.845774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:54.861895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:54.862208) ========= 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=6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-22 04:26: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% 46.0M=0s 2017-05-22 04:26:56 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.261841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:55.136949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:55.137259) ========= 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=6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:55.186269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:55.186604) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4a8c54c2b056a5df90bf2284a25c4bec75bb1be --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 b4a8c54c2b056a5df90bf2284a25c4bec75bb1be --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=6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-22 04:26:56,537 truncating revision to first 12 chars 2017-05-22 04:26:56,537 Setting DEBUG logging. 2017-05-22 04:26:56,537 attempt 1/10 2017-05-22 04:26:56,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4a8c54c2b05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-22 04:26:57,038 unpacking tar archive at: mozilla-central-b4a8c54c2b05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.856679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:56.058529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:56.061883) ========= script_repo_revision: b4a8c54c2b056a5df90bf2284a25c4bec75bb1be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:56.062265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:56.062549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 04:26:56.071328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-05-22 04:26:56.071630) ========= /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=6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:57 INFO - MultiFileLogger online at 20170522 04:26:57 in /builds/slave/test 04:26:57 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 04:26:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:57 INFO - {'append_to_log': False, 04:26:57 INFO - 'base_work_dir': '/builds/slave/test', 04:26:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:26:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:57 INFO - 'branch': 'Firefox-Non-PGO', 04:26:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:57 INFO - 'config_files': ('talos/linux_config.py',), 04:26:57 INFO - 'default_actions': ('clobber', 04:26:57 INFO - 'read-buildbot-config', 04:26:57 INFO - 'download-and-extract', 04:26:57 INFO - 'populate-webroot', 04:26:57 INFO - 'create-virtualenv', 04:26:57 INFO - 'install', 04:26:57 INFO - 'run-tests'), 04:26:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:57 INFO - 'download_minidump_stackwalk': True, 04:26:57 INFO - 'download_symbols': 'ondemand', 04:26:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:57 INFO - 'gecko_profile': False, 04:26:57 INFO - 'gecko_profile_interval': 0, 04:26:57 INFO - 'installer_path': 'installer.exe', 04:26:57 INFO - 'log_level': 'info', 04:26:57 INFO - 'log_name': 'talos', 04:26:57 INFO - 'log_to_console': True, 04:26:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:57 INFO - 'opt_config_files': (), 04:26:57 INFO - 'pip_index': False, 04:26:57 INFO - 'suite': 'dromaeojs-e10s', 04:26:57 INFO - 'system_bits': '32', 04:26:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:57 INFO - 'title': 'talos-linux64-ix-050', 04:26:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:57 INFO - 'use_talos_json': True, 04:26:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:57 INFO - 'work_dir': 'build'} 04:26:57 INFO - [mozharness: 2017-05-22 11:26:57.524579Z] Running clobber step. 04:26:57 INFO - Running pre-action listener: _resource_record_pre_action 04:26:57 INFO - Running main action method: clobber 04:26:57 INFO - rmtree: /builds/slave/test/build 04:26:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:58 INFO - Running post-action listener: _resource_record_post_action 04:26:58 INFO - [mozharness: 2017-05-22 11:26:58.540901Z] Finished clobber step (success) 04:26:58 INFO - [mozharness: 2017-05-22 11:26:58.541003Z] Running read-buildbot-config step. 04:26:58 INFO - Running pre-action listener: _resource_record_pre_action 04:26:58 INFO - Running main action method: read_buildbot_config 04:26:58 INFO - Using buildbot properties: 04:26:58 INFO - { 04:26:58 INFO - "project": "", 04:26:58 INFO - "product": "firefox", 04:26:58 INFO - "who": "cbook@mozilla.com", 04:26:58 INFO - "installer_path": "public/build/target.tar.bz2", 04:26:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:26:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:26:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:26:58 INFO - "stage_platform": "linux64", 04:26:58 INFO - "basedir": "/builds/slave/test", 04:26:58 INFO - "buildnumber": 843, 04:26:58 INFO - "platform": "ubuntu64_hw", 04:26:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:26:58 INFO - "slavebuilddir": "test", 04:26:58 INFO - "taskId": "FXQtH1daTCyuFcGjTdeGXA", 04:26:58 INFO - "branch": "mozilla-central", 04:26:58 INFO - "script_repo_revision": "production", 04:26:58 INFO - "revision": "b4a8c54c2b056a5df90bf2284a25c4bec75bb1be", 04:26:58 INFO - "slavename": "talos-linux64-ix-050", 04:26:58 INFO - "repo_path": "mozilla-central" 04:26:58 INFO - } 04:26:58 INFO - Finding installer, test and symbols from parent task. 04:26:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXQtH1daTCyuFcGjTdeGXA'}, attempt #1 04:26:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXQtH1daTCyuFcGjTdeGXA'}, attempt #1 04:26:59 INFO - Task dependencies: RhFYWNzWT6ae80C-QxBHVQ 04:26:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ'}, attempt #1 04:27:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2 04:27:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/test_packages.json 04:27:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.crashreporter-symbols.zip 04:27:00 INFO - Running post-action listener: _resource_record_post_action 04:27:00 INFO - [mozharness: 2017-05-22 11:27:00.108127Z] Finished read-buildbot-config step (success) 04:27:00 INFO - [mozharness: 2017-05-22 11:27:00.108348Z] Running download-and-extract step. 04:27:00 INFO - Running pre-action listener: _resource_record_pre_action 04:27:00 INFO - Running main action method: download_and_extract 04:27:00 INFO - mkdir: /builds/slave/test/build/tests 04:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:00 INFO - trying https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.test_packages.json 04:27:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:27:00 INFO - Downloaded 986 bytes. 04:27:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:27:00 INFO - Using the following test package requirements: 04:27:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:27:00 INFO - u'common': [u'target.common.tests.zip'], 04:27:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:27:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:27:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:27:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:27:00 INFO - u'mozbase': [u'target.common.tests.zip'], 04:27:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:27:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:27:00 INFO - u'web-platform': [u'target.common.tests.zip', 04:27:00 INFO - u'target.web-platform.tests.zip'], 04:27:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:27:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:27:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.common.tests.zip 04:27:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:27:00 INFO - Fetch https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.common.tests.zip into memory 04:27:02 INFO - Content-Length response header: 63520782 04:27:02 INFO - Bytes received: 63520782 04:27:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:27:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.common.tests.zip 04:27:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:27:13 INFO - Fetch https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.common.tests.zip into memory 04:27:16 INFO - Content-Length response header: 63520782 04:27:16 INFO - Bytes received: 63520782 04:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.talos.tests.zip 04:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.talos.tests.zip into memory 04:27:31 INFO - Content-Length response header: 14410000 04:27:31 INFO - Bytes received: 14410000 04:27: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')]} 04:27:31 INFO - trying https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2 04:27:31 INFO - Downloading https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:27:36 INFO - Downloaded 54930551 bytes. 04:27:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2 04:27:36 INFO - mkdir: /builds/slave/test/properties 04:27:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:36 INFO - Contents: 04:27:36 INFO - build_url:https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2 04:27:36 INFO - Running post-action listener: _resource_record_post_action 04:27:36 INFO - Running post-action listener: set_extra_try_arguments 04:27:36 INFO - [mozharness: 2017-05-22 11:27:36.392805Z] Finished download-and-extract step (success) 04:27:36 INFO - [mozharness: 2017-05-22 11:27:36.393034Z] Running populate-webroot step. 04:27:36 INFO - Running pre-action listener: _resource_record_pre_action 04:27:36 INFO - Running main action method: populate_webroot 04:27:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:36 INFO - '--tppagecycles', 04:27:36 INFO - '7'], 04:27:36 INFO - 'tests': ['tsvgm']}}, 04:27:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['damp', 'tps']}, 04:27:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'tests': ['damp', 'tps']}, 04:27:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['dromaeo_dom']}, 04:27:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:27:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:27:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'tests': ['ts_paint', 'tp5o']}, 04:27:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['a11yr', 04:27:36 INFO - 'ts_paint', 04:27:36 INFO - 'tpaint', 04:27:36 INFO - 'sessionrestore', 04:27:36 INFO - 'sessionrestore_no_auto_restore', 04:27:36 INFO - 'tabpaint']}, 04:27:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:36 INFO - 'ts_paint', 04:27:36 INFO - 'tpaint', 04:27:36 INFO - 'sessionrestore', 04:27:36 INFO - 'sessionrestore_no_auto_restore', 04:27:36 INFO - 'tabpaint']}, 04:27:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:36 INFO - 'ts_paint', 04:27:36 INFO - 'tpaint', 04:27:36 INFO - 'sessionrestore', 04:27:36 INFO - 'sessionrestore_no_auto_restore', 04:27:36 INFO - 'tabpaint']}, 04:27:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:36 INFO - 'ts_paint', 04:27:36 INFO - 'tpaint', 04:27:36 INFO - 'sessionrestore', 04:27:36 INFO - 'sessionrestore_no_auto_restore', 04:27:36 INFO - 'tabpaint']}, 04:27:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['a11yr', 04:27:36 INFO - 'ts_paint', 04:27:36 INFO - 'tpaint', 04:27:36 INFO - 'sessionrestore', 04:27:36 INFO - 'sessionrestore_no_auto_restore', 04:27:36 INFO - 'tabpaint']}, 04:27:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['a11yr', 04:27:36 INFO - 'ts_paint', 04:27:36 INFO - 'tpaint', 04:27:36 INFO - 'sessionrestore', 04:27:36 INFO - 'sessionrestore_no_auto_restore', 04:27:36 INFO - 'tabpaint']}, 04:27:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:27:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:27:36 INFO - 'bloom_basic_ref']}, 04:27:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['tsvgx', 04:27:36 INFO - 'tsvgr_opacity', 04:27:36 INFO - 'tart', 04:27:36 INFO - 'tscrollx', 04:27:36 INFO - 'cart', 04:27:36 INFO - 'tsvg_static']}, 04:27:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:36 INFO - 'tsvgr_opacity', 04:27:36 INFO - 'tart', 04:27:36 INFO - 'tscrollx', 04:27:36 INFO - 'cart', 04:27:36 INFO - 'tsvg_static']}, 04:27:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'talos_options': ['--disable-e10s'], 04:27:36 INFO - 'tests': ['tp5o']}, 04:27:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:27:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'talos_options': ['--disable-e10s', 04:27:36 INFO - '--xperf_path', 04:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:36 INFO - 'tests': ['tp5n']}, 04:27:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:27:36 INFO - 'talos_options': ['--xperf_path', 04:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:36 INFO - 'tests': ['tp5n']}}, 04:27:36 INFO - 'talos.zip': {'path': '', 04:27:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:36 INFO - Running post-action listener: _resource_record_post_action 04:27:36 INFO - [mozharness: 2017-05-22 11:27:36.412265Z] Finished populate-webroot step (success) 04:27:36 INFO - [mozharness: 2017-05-22 11:27:36.412355Z] Running create-virtualenv step. 04:27:36 INFO - Running pre-action listener: _resource_record_pre_action 04:27:36 INFO - Running main action method: create_virtualenv 04:27:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:36 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 04:27:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:36 INFO - Using real prefix '/usr' 04:27:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:38 INFO - Installing pip.................done. 04:27:38 INFO - Return code: 0 04:27:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:27:39 INFO - Reading from file tmpfile_stdout 04:27:39 INFO - Output received: 04:27:39 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) 04:27:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27: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')]} 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:39 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:39 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 04:27:39 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 04:27:39 INFO - Using env: {'DISPLAY': ':0', 04:27:39 INFO - 'HOME': '/home/cltbld', 04:27:39 INFO - 'LANG': 'en_US.UTF-8', 04:27:39 INFO - 'LANGUAGE': 'en_US:en', 04:27:39 INFO - 'LOGNAME': 'cltbld', 04:27:39 INFO - 'MAIL': '/var/mail/cltbld', 04:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:39 INFO - 'MOZ_NO_REMOTE': '1', 04:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:39 INFO - 'NO_EM_RESTART': '1', 04:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:39 INFO - 'PWD': '/builds/slave/test', 04:27:39 INFO - 'SHELL': '/bin/bash', 04:27:39 INFO - 'SHLVL': '1', 04:27:39 INFO - 'TERM': 'linux', 04:27:39 INFO - 'TMOUT': '86400', 04:27:39 INFO - 'USER': 'cltbld', 04:27:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:39 INFO - '_': '/tools/buildbot/bin/python'} 04:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:39 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 04:27:39 INFO - Cleaning up... 04:27:39 INFO - Return code: 0 04:27:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27: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')]} 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:39 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:39 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 04:27:39 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 04:27:39 INFO - Using env: {'DISPLAY': ':0', 04:27:39 INFO - 'HOME': '/home/cltbld', 04:27:39 INFO - 'LANG': 'en_US.UTF-8', 04:27:39 INFO - 'LANGUAGE': 'en_US:en', 04:27:39 INFO - 'LOGNAME': 'cltbld', 04:27:39 INFO - 'MAIL': '/var/mail/cltbld', 04:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:39 INFO - 'MOZ_NO_REMOTE': '1', 04:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:39 INFO - 'NO_EM_RESTART': '1', 04:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:39 INFO - 'PWD': '/builds/slave/test', 04:27:39 INFO - 'SHELL': '/bin/bash', 04:27:39 INFO - 'SHLVL': '1', 04:27:39 INFO - 'TERM': 'linux', 04:27:39 INFO - 'TMOUT': '86400', 04:27:39 INFO - 'USER': 'cltbld', 04:27:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:39 INFO - '_': '/tools/buildbot/bin/python'} 04:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:39 INFO - Downloading/unpacking psutil>=3.1.1 04:27: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 04:27: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 04:27: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 04:27: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 04:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:40 INFO - Installing collected packages: psutil 04:27:40 INFO - Running setup.py install for psutil 04:27:40 INFO - building 'psutil._psutil_linux' extension 04:27:40 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 04:27:41 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 04:27:41 INFO - building 'psutil._psutil_posix' extension 04:27:41 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 04:27:41 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 04:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:41 INFO - Successfully installed psutil 04:27:41 INFO - Cleaning up... 04:27:41 INFO - Return code: 0 04:27:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:41 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:41 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 04:27:41 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 04:27:41 INFO - Using env: {'DISPLAY': ':0', 04:27:41 INFO - 'HOME': '/home/cltbld', 04:27:41 INFO - 'LANG': 'en_US.UTF-8', 04:27:41 INFO - 'LANGUAGE': 'en_US:en', 04:27:41 INFO - 'LOGNAME': 'cltbld', 04:27:41 INFO - 'MAIL': '/var/mail/cltbld', 04:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:41 INFO - 'MOZ_NO_REMOTE': '1', 04:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:41 INFO - 'NO_EM_RESTART': '1', 04:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:41 INFO - 'PWD': '/builds/slave/test', 04:27:41 INFO - 'SHELL': '/bin/bash', 04:27:41 INFO - 'SHLVL': '1', 04:27:41 INFO - 'TERM': 'linux', 04:27:41 INFO - 'TMOUT': '86400', 04:27:41 INFO - 'USER': 'cltbld', 04:27:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:41 INFO - '_': '/tools/buildbot/bin/python'} 04:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:41 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 04:27:41 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 04:27:41 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 04:27:41 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 04:27:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:42 INFO - Installing collected packages: mozsystemmonitor 04:27:42 INFO - Running setup.py install for mozsystemmonitor 04:27:42 INFO - Successfully installed mozsystemmonitor 04:27:42 INFO - Cleaning up... 04:27:43 INFO - Return code: 0 04:27:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27: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')]} 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:27:43 INFO - Using env: {'DISPLAY': ':0', 04:27:43 INFO - 'HOME': '/home/cltbld', 04:27:43 INFO - 'LANG': 'en_US.UTF-8', 04:27:43 INFO - 'LANGUAGE': 'en_US:en', 04:27:43 INFO - 'LOGNAME': 'cltbld', 04:27:43 INFO - 'MAIL': '/var/mail/cltbld', 04:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:43 INFO - 'MOZ_NO_REMOTE': '1', 04:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:43 INFO - 'NO_EM_RESTART': '1', 04:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:43 INFO - 'PWD': '/builds/slave/test', 04:27:43 INFO - 'SHELL': '/bin/bash', 04:27:43 INFO - 'SHLVL': '1', 04:27:43 INFO - 'TERM': 'linux', 04:27:43 INFO - 'TMOUT': '86400', 04:27:43 INFO - 'USER': 'cltbld', 04:27:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:43 INFO - '_': '/tools/buildbot/bin/python'} 04:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:43 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:45 INFO - warning: no files found matching '*.txt' 04:27:45 INFO - no previously-included directories found matching 'build' 04:27:45 INFO - no previously-included directories found matching 'dist' 04:27:45 INFO - no previously-included directories found matching '.git*' 04:27:45 INFO - Installing collected packages: jsonschema, functools32 04:27:45 INFO - Running setup.py install for functools32 04:27:45 INFO - warning: no files found matching '*.txt' 04:27:45 INFO - no previously-included directories found matching 'build' 04:27:45 INFO - no previously-included directories found matching 'dist' 04:27:45 INFO - no previously-included directories found matching '.git*' 04:27:45 INFO - Successfully installed jsonschema functools32 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:27:45 INFO - Using env: {'DISPLAY': ':0', 04:27:45 INFO - 'HOME': '/home/cltbld', 04:27:45 INFO - 'LANG': 'en_US.UTF-8', 04:27:45 INFO - 'LANGUAGE': 'en_US:en', 04:27:45 INFO - 'LOGNAME': 'cltbld', 04:27:45 INFO - 'MAIL': '/var/mail/cltbld', 04:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:45 INFO - 'MOZ_NO_REMOTE': '1', 04:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:45 INFO - 'NO_EM_RESTART': '1', 04:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:45 INFO - 'PWD': '/builds/slave/test', 04:27:45 INFO - 'SHELL': '/bin/bash', 04:27:45 INFO - 'SHLVL': '1', 04:27:45 INFO - 'TERM': 'linux', 04:27:45 INFO - 'TMOUT': '86400', 04:27:45 INFO - 'USER': 'cltbld', 04:27:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:45 INFO - '_': '/tools/buildbot/bin/python'} 04:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:27:45 INFO - Using env: {'DISPLAY': ':0', 04:27:45 INFO - 'HOME': '/home/cltbld', 04:27:45 INFO - 'LANG': 'en_US.UTF-8', 04:27:45 INFO - 'LANGUAGE': 'en_US:en', 04:27:45 INFO - 'LOGNAME': 'cltbld', 04:27:45 INFO - 'MAIL': '/var/mail/cltbld', 04:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:45 INFO - 'MOZ_NO_REMOTE': '1', 04:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:45 INFO - 'NO_EM_RESTART': '1', 04:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:45 INFO - 'PWD': '/builds/slave/test', 04:27:45 INFO - 'SHELL': '/bin/bash', 04:27:45 INFO - 'SHLVL': '1', 04:27:45 INFO - 'TERM': 'linux', 04:27:45 INFO - 'TMOUT': '86400', 04:27:45 INFO - 'USER': 'cltbld', 04:27:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:45 INFO - '_': '/tools/buildbot/bin/python'} 04:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:27: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 04:27: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 04:27: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 04:27: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 04:27:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:48 INFO - Downloading docopt-0.6.1.tar.gz 04:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:48 INFO - Running setup.py install for blobuploader 04:27:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:48 INFO - Running setup.py install for requests 04:27:49 INFO - Running setup.py install for docopt 04:27:49 INFO - Successfully installed blobuploader requests docopt 04:27:49 INFO - Cleaning up... 04:27:49 INFO - Return code: 0 04:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:49 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:49 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 04:27:49 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 04:27:49 INFO - Using env: {'DISPLAY': ':0', 04:27:49 INFO - 'HOME': '/home/cltbld', 04:27:49 INFO - 'LANG': 'en_US.UTF-8', 04:27:49 INFO - 'LANGUAGE': 'en_US:en', 04:27:49 INFO - 'LOGNAME': 'cltbld', 04:27:49 INFO - 'MAIL': '/var/mail/cltbld', 04:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:49 INFO - 'MOZ_NO_REMOTE': '1', 04:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:49 INFO - 'NO_EM_RESTART': '1', 04:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:49 INFO - 'PWD': '/builds/slave/test', 04:27:49 INFO - 'SHELL': '/bin/bash', 04:27:49 INFO - 'SHLVL': '1', 04:27:49 INFO - 'TERM': 'linux', 04:27:49 INFO - 'TMOUT': '86400', 04:27:49 INFO - 'USER': 'cltbld', 04:27:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:49 INFO - '_': '/tools/buildbot/bin/python'} 04:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:49 INFO - Running setup.py (path:/tmp/pip-4tj0EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:49 INFO - Running setup.py (path:/tmp/pip-1RmOnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:49 INFO - Running setup.py (path:/tmp/pip-iFyjyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:49 INFO - Running setup.py (path:/tmp/pip-q_GLUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:49 INFO - Running setup.py (path:/tmp/pip-yKQHiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:49 INFO - Running setup.py (path:/tmp/pip-Ecy9bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:49 INFO - Running setup.py (path:/tmp/pip-9kVUxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:50 INFO - Running setup.py (path:/tmp/pip-Q_xXCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:50 INFO - Running setup.py (path:/tmp/pip-Eec1mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:50 INFO - Running setup.py (path:/tmp/pip-NR3UFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:50 INFO - Running setup.py (path:/tmp/pip-4uOZUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:50 INFO - Running setup.py (path:/tmp/pip-jj8vCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:50 INFO - Running setup.py (path:/tmp/pip-Ih3XS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:50 INFO - Running setup.py (path:/tmp/pip-gkt9xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:50 INFO - Running setup.py (path:/tmp/pip-9onSxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:50 INFO - Running setup.py (path:/tmp/pip-V2NJng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:50 INFO - Running setup.py (path:/tmp/pip-mjTUSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:50 INFO - Running setup.py install for manifestparser 04:27:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:50 INFO - Running setup.py install for mozcrash 04:27:50 INFO - Running setup.py install for mozdebug 04:27:51 INFO - Running setup.py install for mozdevice 04:27:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Running setup.py install for mozfile 04:27:51 INFO - Running setup.py install for mozhttpd 04:27:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Running setup.py install for mozinfo 04:27:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Running setup.py install for mozInstall 04:27:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Running setup.py install for mozleak 04:27:51 INFO - Running setup.py install for mozlog 04:27:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Running setup.py install for moznetwork 04:27:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:51 INFO - Running setup.py install for mozprocess 04:27:51 INFO - Running setup.py install for mozprofile 04:27:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Running setup.py install for mozrunner 04:27:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Running setup.py install for mozscreenshot 04:27:52 INFO - Running setup.py install for moztest 04:27:52 INFO - Running setup.py install for mozversion 04:27:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:52 INFO - Cleaning up... 04:27:52 INFO - Return code: 0 04:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:52 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:52 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 04:27:52 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 04:27:52 INFO - Using env: {'DISPLAY': ':0', 04:27:52 INFO - 'HOME': '/home/cltbld', 04:27:52 INFO - 'LANG': 'en_US.UTF-8', 04:27:52 INFO - 'LANGUAGE': 'en_US:en', 04:27:52 INFO - 'LOGNAME': 'cltbld', 04:27:52 INFO - 'MAIL': '/var/mail/cltbld', 04:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:52 INFO - 'MOZ_NO_REMOTE': '1', 04:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:52 INFO - 'NO_EM_RESTART': '1', 04:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:52 INFO - 'PWD': '/builds/slave/test', 04:27:52 INFO - 'SHELL': '/bin/bash', 04:27:52 INFO - 'SHLVL': '1', 04:27:52 INFO - 'TERM': 'linux', 04:27:52 INFO - 'TMOUT': '86400', 04:27:52 INFO - 'USER': 'cltbld', 04:27:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:52 INFO - '_': '/tools/buildbot/bin/python'} 04:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:52 INFO - Running setup.py (path:/tmp/pip-iqdi7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:52 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)) 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:52 INFO - Running setup.py (path:/tmp/pip-xWAkIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:52 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)) 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:52 INFO - Running setup.py (path:/tmp/pip-uLHYZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:52 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)) 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:52 INFO - Running setup.py (path:/tmp/pip-uclRSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:53 INFO - Running setup.py (path:/tmp/pip-QsyUOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:53 INFO - Running setup.py (path:/tmp/pip-wYNpqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:53 INFO - Running setup.py (path:/tmp/pip-6iva5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:53 INFO - Running setup.py (path:/tmp/pip-gGVVKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:53 INFO - Running setup.py (path:/tmp/pip-K_MoZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:53 INFO - Running setup.py (path:/tmp/pip-a9Sdwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:53 INFO - Running setup.py (path:/tmp/pip-jsIW59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:53 INFO - Running setup.py (path:/tmp/pip-EusKj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:53 INFO - Running setup.py (path:/tmp/pip-Zp1NAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:53 INFO - Running setup.py (path:/tmp/pip-Ek3Ht6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:53 INFO - Running setup.py (path:/tmp/pip-tYnxoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:53 INFO - Running setup.py (path:/tmp/pip-EkOG3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:53 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)) 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:53 INFO - Running setup.py (path:/tmp/pip-7XZO9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:54 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)) 04:27:54 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)) 04:27:54 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)) 04:27:54 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)) 04:27:54 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)) 04:27:54 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)) 04:27:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:55 INFO - Downloading blessings-1.6.tar.gz 04:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:55 INFO - Installing collected packages: blessings 04:27:55 INFO - Running setup.py install for blessings 04:27:55 INFO - Successfully installed blessings 04:27:55 INFO - Cleaning up... 04:27:55 INFO - Return code: 0 04:27:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:55 INFO - Reading from file tmpfile_stdout 04:27:55 INFO - Current package versions: 04:27:55 INFO - argparse == 1.2.1 04:27:55 INFO - blessings == 1.6 04:27:55 INFO - blobuploader == 1.2.4 04:27:55 INFO - docopt == 0.6.1 04:27:55 INFO - functools32 == 3.2.3-2 04:27:55 INFO - jsonschema == 2.5.1 04:27:55 INFO - manifestparser == 1.1 04:27:55 INFO - mozInstall == 1.12 04:27:55 INFO - mozcrash == 1.0 04:27:55 INFO - mozdebug == 0.1 04:27:55 INFO - mozdevice == 0.50 04:27:55 INFO - mozfile == 1.2 04:27:55 INFO - mozhttpd == 0.7 04:27:55 INFO - mozinfo == 0.9 04:27:55 INFO - mozleak == 0.1 04:27:55 INFO - mozlog == 3.4 04:27:55 INFO - moznetwork == 0.27 04:27:55 INFO - mozprocess == 0.25 04:27:55 INFO - mozprofile == 0.28 04:27:55 INFO - mozrunner == 6.13 04:27:55 INFO - mozscreenshot == 0.1 04:27:55 INFO - mozsystemmonitor == 0.3 04:27:55 INFO - moztest == 0.8 04:27:55 INFO - mozversion == 1.4 04:27:55 INFO - psutil == 3.1.1 04:27:55 INFO - requests == 1.2.3 04:27:55 INFO - wsgiref == 0.1.2 04:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:55 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:55 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 04:27:55 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 04:27:55 INFO - Using env: {'DISPLAY': ':0', 04:27:55 INFO - 'HOME': '/home/cltbld', 04:27:55 INFO - 'LANG': 'en_US.UTF-8', 04:27:55 INFO - 'LANGUAGE': 'en_US:en', 04:27:55 INFO - 'LOGNAME': 'cltbld', 04:27:55 INFO - 'MAIL': '/var/mail/cltbld', 04:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:55 INFO - 'MOZ_NO_REMOTE': '1', 04:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:55 INFO - 'NO_EM_RESTART': '1', 04:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:55 INFO - 'PWD': '/builds/slave/test', 04:27:55 INFO - 'SHELL': '/bin/bash', 04:27:55 INFO - 'SHLVL': '1', 04:27:55 INFO - 'TERM': 'linux', 04:27:55 INFO - 'TMOUT': '86400', 04:27:55 INFO - 'USER': 'cltbld', 04:27:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:55 INFO - '_': '/tools/buildbot/bin/python'} 04:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 INFO - Cleaning up... 04:27:55 INFO - Return code: 0 04:27:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:55 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 0x286a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, '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': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', '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 04:27:55 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 04:27:55 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 04:27:55 INFO - Using env: {'DISPLAY': ':0', 04:27:55 INFO - 'HOME': '/home/cltbld', 04:27:55 INFO - 'LANG': 'en_US.UTF-8', 04:27:55 INFO - 'LANGUAGE': 'en_US:en', 04:27:55 INFO - 'LOGNAME': 'cltbld', 04:27:55 INFO - 'MAIL': '/var/mail/cltbld', 04:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:55 INFO - 'MOZ_NO_REMOTE': '1', 04:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:55 INFO - 'NO_EM_RESTART': '1', 04:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:55 INFO - 'PWD': '/builds/slave/test', 04:27:55 INFO - 'SHELL': '/bin/bash', 04:27:55 INFO - 'SHLVL': '1', 04:27:55 INFO - 'TERM': 'linux', 04:27:55 INFO - 'TMOUT': '86400', 04:27:55 INFO - 'USER': 'cltbld', 04:27:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:55 INFO - '_': '/tools/buildbot/bin/python'} 04:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:56 INFO - Cleaning up... 04:27:56 INFO - Return code: 0 04:27:56 INFO - Running post-action listener: _resource_record_post_action 04:27:56 INFO - Running post-action listener: _start_resource_monitoring 04:27:56 INFO - Starting resource monitoring. 04:27:56 INFO - [mozharness: 2017-05-22 11:27:56.168470Z] Finished create-virtualenv step (success) 04:27:56 INFO - [mozharness: 2017-05-22 11:27:56.168979Z] Running install step. 04:27:56 INFO - Running pre-action listener: _resource_record_pre_action 04:27:56 INFO - Running main action method: install 04:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:56 INFO - Reading from file tmpfile_stdout 04:27:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:56 INFO - Reading from file tmpfile_stdout 04:27:56 INFO - Output received: 04:27:56 INFO - Usage: mozinstall [options] installer 04:27:56 INFO - Options: 04:27:56 INFO - -h, --help show this help message and exit 04:27:56 INFO - -d DEST, --destination=DEST 04:27:56 INFO - Directory to install application into. [default: 04:27:56 INFO - "/builds/slave/test"] 04:27:56 INFO - --app=APP Application being installed. [default: firefox] 04:27:56 INFO - mkdir: /builds/slave/test/build/application 04:27:56 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'] 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:28:12 INFO - Reading from file tmpfile_stdout 04:28:12 INFO - Output received: 04:28:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:28:12 INFO - Running post-action listener: _resource_record_post_action 04:28:12 INFO - [mozharness: 2017-05-22 11:28:12.161640Z] Finished install step (success) 04:28:12 INFO - [mozharness: 2017-05-22 11:28:12.161919Z] Running run-tests step. 04:28:12 INFO - Running pre-action listener: _resource_record_pre_action 04:28:12 INFO - Running main action method: run_tests 04:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:12 INFO - Python 2.7.3 04:28:12 INFO - Return code: 0 04:28:12 INFO - grabbing minidump binary from tooltool 04:28:12 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')]} 04:28:12 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 0x2bda7a0>, '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 0x2bdb6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:12 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 04:28:12 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 04:28:12 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 04:28:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:12 INFO - Return code: 0 04:28:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:28:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:12 INFO - ENV: RUST_BACKTRACE is now 1 04:28:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:28:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:12 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/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:28:12 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/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 04:28:12 INFO - Using env: {'DISPLAY': ':0', 04:28:12 INFO - 'HOME': '/home/cltbld', 04:28:12 INFO - 'LANG': 'en_US.UTF-8', 04:28:12 INFO - 'LANGUAGE': 'en_US:en', 04:28:12 INFO - 'LOGNAME': 'cltbld', 04:28:12 INFO - 'MAIL': '/var/mail/cltbld', 04:28:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:12 INFO - 'MOZ_NO_REMOTE': '1', 04:28:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:12 INFO - 'NO_EM_RESTART': '1', 04:28:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:12 INFO - 'PWD': '/builds/slave/test', 04:28:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:12 INFO - 'RUST_BACKTRACE': '1', 04:28:12 INFO - 'SHELL': '/bin/bash', 04:28:12 INFO - 'SHLVL': '1', 04:28:12 INFO - 'TERM': 'linux', 04:28:12 INFO - 'TMOUT': '86400', 04:28:12 INFO - 'USER': 'cltbld', 04:28:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227', 04:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:12 INFO - '_': '/tools/buildbot/bin/python'} 04:28:12 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/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:28:12 INFO - mozversion application_buildid: 20170522105704 04:28:12 INFO - mozversion application_changeset: b4a8c54c2b056a5df90bf2284a25c4bec75bb1be 04:28:12 INFO - mozversion application_display_name: Nightly 04:28:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:12 INFO - mozversion application_name: Firefox 04:28:12 INFO - mozversion application_remotingname: firefox 04:28:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:28:12 INFO - mozversion application_vendor: Mozilla 04:28:12 INFO - mozversion application_version: 55.0a1 04:28:12 INFO - mozversion platform_buildid: 20170522105704 04:28:12 INFO - mozversion platform_changeset: b4a8c54c2b056a5df90bf2284a25c4bec75bb1be 04:28:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:28:12 INFO - mozversion platform_version: 55.0a1 04:28:12 INFO - using testdate: 1495452492 04:28:12 INFO - actual date: 1495452492 04:28:12 INFO - starting webserver on 'localhost:43740' 04:28:12 INFO - SUITE-START | Running 2 tests 04:28:12 INFO - TEST-START | dromaeo_css 04:28:12 INFO - operating with platform_type : linux_ 04:28:12 INFO - Initialising browser for dromaeo_css test... 04:28:12 INFO - TEST-INFO | started process 28633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps1ak1G/profile http://localhost:43740/getInfo.html) 04:28:13 INFO - PID 28633 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:28:16 INFO - PID 28633 | __metrics Screen width/height:1600/1200 04:28:16 INFO - PID 28633 | colorDepth:24 04:28:16 INFO - PID 28633 | Browser inner width/height: 1024/695 04:28:16 INFO - PID 28633 | __metrics 04:28:18 INFO - TEST-INFO | 28633: exit 0 04:28:18 INFO - Browser initialized. 04:28:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:18 INFO - TEST-INFO | started process 28795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps1ak1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:30 INFO - PID 28795 | RSS: Main: 166154240 04:28:30 INFO - PID 28795 | 04:31:35 INFO - PID 28795 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43740/tests/dromaeo/cssquery-ext.html) 04:31:36 INFO - PID 28795 | RSS: Main: 169492480 04:31:36 INFO - PID 28795 | 04:34:38 INFO - PID 28795 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-ext.html (next: http://localhost:43740/tests/dromaeo/cssquery-jquery.html) 04:34:38 INFO - PID 28795 | RSS: Main: 169013248 04:34:38 INFO - PID 28795 | 04:37:40 INFO - PID 28795 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43740/tests/dromaeo/cssquery-mootools.html) 04:37:41 INFO - PID 28795 | RSS: Main: 170491904 04:37:41 INFO - PID 28795 | 04:40:42 INFO - PID 28795 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43740/tests/dromaeo/cssquery-prototype.html) 04:40:43 INFO - PID 28795 | RSS: Main: 168759296 04:40:43 INFO - PID 28795 | 04:43:46 INFO - PID 28795 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43740/tests/dromaeo/cssquery-yui.html) 04:43:47 INFO - PID 28795 | RSS: Main: 169463808 04:43:47 INFO - PID 28795 | 04:46:48 INFO - PID 28795 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-yui.html (next: http://localhost:43740/tests/dromaeo/cssquery-dojo.html) 04:46:49 INFO - PID 28795 | RSS: Main: 168857600 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | __start_tp_report 04:46:49 INFO - PID 28795 | _x_x_mozilla_page_load 04:46:49 INFO - PID 28795 | _x_x_mozilla_page_load_details 04:46:49 INFO - PID 28795 | |i|pagename|runs| 04:46:49 INFO - PID 28795 | |0;dojo.html;2681.9999999999995;2699.2981824725566;2716.904908328209;2737.575675770256;2742.9725702742967;5154.123798954178;5155.639105262633;5219.685499707689;5226.29445024922;5249.7375131243425;5189.299444574981;5283.233931080001;5296;5304.3634763828295;5309.203619457084;4646.86059418218;4650.325702773096;4686.250199968006;4687.859364219079;4723.267893476499;4601.263797792354;4667.789949452283;4681.46163191234;4685.5314468553215;4741.525847415248;4644.628429725648;4674.509176536449;4692.460367057798;4693.718376897397;4698.600618947394;4605.332226827091;4616.122936642061;4621.4223222097235;4648.48866624671;4677.532246775329;4542.273236282179;4590.540945905416;4592.380028696117;4654.930176047362;4666.813327466897;5080.187170052774;5115.565176959963;5133.358330208724;5138.229265610151;5171.4311425743135;5482.068048431736;5632.014397480424;5639.915401268984;5643.943560564383;5656.208130861683;5710.457506536873;5729.885402291972;5732.541396688297;5732.914006289909;5746.9425305747245;5310.60170487215;5319.867003324948;5329.786808527693;5330.040592693353;5331.86670333237;5750.396208398141;5855.2973643163095;5882.294124704978;5892.882142357214;5918.615290006222;5516.117421212587;5592.608517403824;5601.991641504568;5619.943800562024;5671.461211184931;5553.583481238923;5668.546516278688;5672.858178545487;5683.2895888014;5695.971520142372;5599.636023658531;5609.270794796732;5615.719214039364;5660.2075709400715;5664.773409063674;5593.216949627055;5600.047991841397;5633.155026745939;5643.435656434406;5673.035583950656;4671.229247174178;4744.264638980894;4767.833125840648;4770.475247722748;4794.5924596409695;3949.328614135604;3996.500437445319;4014.136960553495;4044.090079732037;4080.020795009236;4854.83008094722;4865.294532292868;4866.829660961849;4867.294242334841;4922.975385123052;5698.686572238566;5711.485966262973;5713.514351280104;5722.685252311079;5737.225474560964;4734.668573199843;4785.3300537924715;4832.395950506187;4836.105320515646;4841.176999910023;5010.5240002199735;5016.072026675077;5025.422076461181;5025.899482010339;5056.241563765465;5237.450067742984;5238.266642669953;5252.894942101213;5273.129933560919;5279.868003299948;5567.220589117608;5646.632968857011;5690.658560486384;5698.886022279448;5701.942980570141;5226.63413561047;5282.9471705283995;5287.788488460418;5294.152935530296;5323.121684922099;5589.273394458694;5599.468050535193;5605.411431799603;5607.130894711327;5610.971945140412;5559.833205003856;5645.096784514458;5655.406182350958;5662.320521537442;5664.971675141763;5464.098423760035;5497.835064948058;5510.779568817203;5512.118061110203;5558.082916318762;5374.946250537445;5488.670679759227;5511.283533140827;5550.639208451437;5579.77680892776;5231.633785635121;5335.1730481775385;5415.296011518478;5518.33779946409;5518.558515318845;5443.374011988672;5559.777608895761;5573.247611572386;5575.804846830504;5596.468335508121;5363.222332761806;5399.595030372816;5400;5421.024215641065;5449.536789372948 04:46:49 INFO - PID 28795 | |1;ext.html;680.5406350713267;722.6025685872769;744.4825846037003;912.7991841794803;929.5538141691992;32903.83548082259;33741.66258337416;33849.153771155674;33903.32193356132;33990.83004584977;34632.48051279233;35135;35193.648063519424;35261.47107793385;35335.82332088342;6621;6771.661416929134;6933.791986240421;7075.610841403746;7092;7018.33325834045;7096.112985876765;7104.85790284194;7126.11158043119;7148.463865210104;7009.228984811667;7102.538335008208;7128.536645118051;7159.105111861018;7170;7122.78631641049;7126.501144919857;7136;7136.07231059964;7141.571505709648;7013.964930175367;7016.158061032709;7026.367626913602;7053.788386348418;7058.541194822372;30981.070567882773;31419.842900785578;31459;31480.212994675087;31500.842495787605;2872.6840047594746;2875.5542890851953;2894.1462268630803;2895.6669982951807;2898.666653334851;24542.877285613635;24624.138155164484;24626.630600541008;24636.630450543256;24692.50614987708;2958.097780177045;2970.3316753730455;2979.6424429068434;2982.478066338404;2989.9551506727416;138521.22957540792;139945;140308;148654;151344.243278784;38450.61549384526;39148.80425597854;39159.80420097881;39196.412053819215;39298.2140357197;40976.38535421971;41016.38475422871;41035.58964410318;41090.38364424536;41099.589004110174;9673.758156046155;9919.65281215154;9936.105750482491;9946.651867184759;9950.054744799232;7768.728094516665;7825.13923468418;7866.174051724601;7872.1340652529325;7874.330681891989;10799.514021869034;10824.837627435594;10915;10988.395638239974;11038.668839934815;4659;4688.64835137366;4693.882652933636;4780.163471392492;4796.952030479721;868.9435186712843;882.4484697064335;890.2032680750692;894.8791913091779;904.1094521895927;20144.19423223084;21063.262785802424;21249.787502124782;21313.040913158944;21619.891900540395;947.7156852944089;950.5484894674975;962.9537233379069;966.2608104799833;981.489625394805;10827.729306767395;11078.723031924104;11333.150013749002;11351.772964540663;11378.431078446045;179078;179268;179939;179980.1000995013;180224.09887950477;40793.388099177944;41356.79321603373;41406.585934140276;41535.169296614506;41688.374674379906;1181.7211603764465;1226.1110694746417;1230.317173968456;1231.1074471008626;1233.0813543909844;18333.16668333156;18475.9791279313;18934.715979260047;19012.429627111207;19016.809831901504;26172.476550469266;26200.606990895532;31988.20029499281;32762.83618581892;32807.34385312233;159445.20277399002;159717;160143;161659;161749;29681.109566713032;29695.851520742257;30015.849920750257;30191.849040755533;30313.848430757706;35860.641393586775;35995.46006809952;36026.27947441089;36159.27681446304;36532.81733591315;27692;27982.86008569944;28049.43901122007;28277.293067673472;28602.28494287576;27053.59419608668;27570.458446307464;27675.723242767315;28425.28936776597;29032.56451153192;29232;30039.098827035225;30068.248293791956;30189;30335.241618959702;26568.33579160459;26944.595831062943;27039.324016899736;27229.319267018484;27818.860905695343;21066.47333816667;22098.116075357448;22462.550748985257;22507.662385064566;22571.774282257626 04:46:49 INFO - PID 28795 | |2;jquery.html;398.2334007036456;410.67966985751116;416.7624454061186;419.3207004652463;438.11282153638876;15731.449399271029;16101.758473622906;16411.83588164118;16432.260548275328;17332;16249.918750406261;16254.268557914893;16477.83522164778;16510.33958641653;16544.75182872258;5250.684958902459;5400.243965844785;5448.945510544883;5457.536109430703;5469.343678758534;5226.973865130669;5344.652597581165;5357.1160758475;5357.142857142858;5357.4374690657505;5343.946560534403;5350.491703288201;5351;5367.114426119686;5371.81198658047;5244.239585260135;5458.263134476834;5480.835574932758;5486.807961721321;5490.039243132456;4823.927641085386;4839.516048395168;4918.336024636664;4934.309196712463;4939.777710003023;22105.778942210694;22470.844789987754;22577.88711056434;22604.773952260595;22716.318510444715;1626.5039163055264;1660.825613310597;1668.5328108129622;1672.105423598381;1674.2716918140648;14162.787558186532;14733.189674567895;15122.924385378003;15170.24148792567;15206.08763474195;1993.7009448582683;2002.4793553676004;2035.4300795777206;2047.754269487671;2053.722747429108;90198.5490072552;90692;92426.53786731091;92556.07443925542;93150.53424732901;10223.693289201336;10355.534000969974;10597.9470102649;10834.512446939907;11030.944845275882;14198.716025679429;14316.284185790877;14422.711545769025;14424.567262982127;14513.129212247299;7231.349178573953;7368.705251789976;7476.70093196277;7610.695572177051;7622.2758837910305;6720.495962802809;6753.3921947025;6775.085363475966;6932.376086152271;7004.614746188907;6873.175218973655;6914.9308506915295;7008.5094043416475;7038.753643622448;7045.788626341218;1966.193860517181;1974.4767636576319;2021.13091370712;2023.1806118522022;2190.912363505474;823.8970128733908;848.4739461533889;855.341387131905;859.9613017414231;871.7210492642294;16355.264013119438;16821.32714691423;17492.38776642837;17679.292828286983;17748.112594370228;854.9658013679383;866.1425189062783;867.6182479708908;871.1462766488877;896.5696465696502;9102.271818254523;9203.40177888435;9410;9551.761205969906;9567.660527526152;358738;360779;361069;365201;372742;69075.65462172657;71975;73070.63464682749;73625.63187184029;74483;1026.830572955454;1048.2976405808126;1069.8983596558314;1072.742541789965;1076.612419528969;14122;14155.150690958575;14289.571312860631;14428.855711442751;14919.701605967603;37462.625373747;37646.62353376431;37909.62090379061;38391.42412863753;38471.23057538777;46189.30716039329;47187.764061180846;47707.5229247717;47989.5201047985;48070.5192948066;7670.961645191738;7805.882911756442;7858.410619203697;7922.366210703015;8022.879656805036;11670.416479175838;11699;11705.180637355303;11856.525738970344;12368.44342004594;10389.584416623251;10487.16102711766;10680.786384272427;10705.304155229886;11466.541338346373;10837.349759014485;10990.890091098987;11008.669739907815;11033.33799971972;11099.334039957628;11616.941915290707;11631;11943.522259109886;12125.81811272814;12213.206141600767;7759.650815713419;7947;7975.680972761024;8059.113497515152;8192;11135.83296250573;11330.773384532427;11343.262687925258;11356.54573817038;11733.706657333634 04:46:49 INFO - PID 28795 | |3;mootools.html;1243.894268987136;1298.6363818130926;1303.2636560343399;1311.1805121798875;1323.3317174826711;9331.626734930604;9748.268879834022;9755;9829.852552211723;10077.748056298597;9930.10629043386;10065.798684026315;10103.747406314846;10104.595816167344;10113.949430252856;2221.1670623516184;2259.7288325400973;2276.4877902471976;2282.2924893283052;2285.759995200505;2156.7519735230494;2176.249194028058;2198.175514323108;2199.164317559333;2201.6587428948537;2186.3768825884626;2193.352960876537;2220.966685499711;2223.621984262671;2244.955100897981;2101.9474513137143;2146.0557354763855;2189.7481789594162;2192.7478339990867;2195.2865318771464;2038.0930485933618;2157.514559224178;2170.6526955687173;2173.4240426287047;2176.336217453676;9185.540722963826;9193.218576420946;9203.907960920438;9224.769380765467;9259.074092590754;5273.419923808378;5469.863253418656;5491.725413729338;5510.531604813596;5521.503064724154;3105.4410206162884;3332.100332910101;3366.882159124443;3375.7468189885612;3390.7117894978956;1032.8863824979246;1063.4948399510172;1064.6646306413531;1069.0485467933545;1082.5020490574345;14012.579622611338;14170;14205.573832785032;14251.78622320666;14322.212278324792;4538.500764915922;4672.252439609646;4827.058723548875;4899.779509922062;4910.165271903785;10017.499125043865;10051.59793608262;10065.64770233053;10080.193584513221;10101.44442055694;5343.278657381204;5345.732713364317;5352.330958630171;5369.946300537023;5373.38206106295;4862.5380588844;4960.627952903546;5031.119554078022;5032.924506132411;5034.0686972910125;3779.225258821935;3788.791616461121;3817.980910095487;3895.3183192941688;4011.8796436106963;1070.0850772589479;1072.6353039966448;1079.5897558927713;1082.4641802307908;1087.374759513283;611.5199568338833;636.9649669268142;641.5284765697209;660.8116686744255;672;5082.313887625123;5260.605454590921;5264.210368444687;5339.065663508871;5406.243125962368;776.4293244465314;802.3380710913519;802.5425507460691;804.9154838741848;824.8102936324678;3025.2739342558066;3029.681883402255;3038.0885734279627;3095.8761649533767;3168.4772012618123;12303.815442768366;12698.174618649942;12817.615471535868;12844.807327890088;12867.48530058806;12627.43176557057;12692.555760548337;12733;12755.489780408865;12763.29801860888;6811.999999999901;6956.2695916928;7035.226125126232;7087.92912070883;7095.50331476802;5674.74463649145;5744.167095771007;5831.446012628793;5900.793472228452;5905.52755779528;10914.23600347968;11406.771864562828;11504.94247528757;11641.53433862636;11701.590444334408;11266.66200014001;11350.489227984926;11424.942875285571;11449.255798373079;11451.828222576834;8003.83992320162;8120.715774947848;8197.754067377988;8260.091389947222;8329.791755205926;8693.608787604699;8918.73243802687;8920.330975177018;8932.106789321017;9003.774905627411;7519.924800751923;7742.458027938215;8001.239882211181;8047.557384343917;8126.75619731409;7713.575753333621;7747.651355688895;7890.684372625031;7981.2018798119725;8019.398545109257;7004.194517630538;7088.582283543209;7123.394511466376;7152.034475345762;7160.964195178991;4776.21192503233;4928.112939670894;5016.322796422436;5048.141815891381;5071.340725705634;5046.1673823818655;5067.645264831426;5111.309973153725;5117.385913690232;5117.411497677815 04:46:49 INFO - PID 28795 | |4;prototype.html;362.99637003629954;371.1556209623107;379.6981399787169;384.56544105161163;387.33958600586004;5465.180222966547;5512.6968016759065;5552.222688823568;5571.275734154565;5663.405342439047;5364.275822763926;5472.50747432731;5475.534579560732;5480.520259529924;5485.862853428656;3996.840126394941;4117.3618089196225;4126.7111302208705;4143.088520525487;4145.2952997990415;4124.319487284594;4138.855140070098;4140.5859414058505;4148;4153.667706583481;4107.979460102695;4114.341705327149;4128.8761337159785;4134.8139333729905;4137.110521237933;4024.75851448914;4089.8773036808648;4097.405876147972;4099.651529619986;4107.383892416146;3590.8743193988084;3591.7665351752053;3593.586737525192;3594.820258987066;3595;5377.247185394048;5383.703896285702;5398.352197736258;5401.540869026137;5411.241346562344;4736.8578942631775;4845.394325709286;4874.65877388583;4882.511748825089;4882.780274887638;5764.798232061899;5819.127130930352;5832.212651292064;5838.824835254949;5853.678047707374;3957.34703773877;3988.262171498282;4002.0195052212393;4003;4003.1393250451;6040.758369665208;6114;6174.722137503778;6187.597806142587;6218.906716399303;4114.526829414655;4118.279301122351;4122.031322639177;4125.23683118618;4125.443065186221;4146.253674338648;4158.521769996429;4163.417121602978;4164.125533637909;4186.727862688916;4618.261078227468;4811.326414302001;4830;4836.758162091881;4845.733484658378;5811.738471768781;5826.592138550345;5831.917657639669;5834.154047663065;5849.532037436995;1422.5021242565226;1428.7926701936847;1435.2106341512126;1437.1018113678952;1438.4318194313187;883.4964070479765;930.7300882744064;932.7015355086443;943.6697155995485;950.8431108867098;5062.924056139161;5070.93510362828;5087.3386459759995;5093.567046801063;5101.591872650179;6007.429294217042;6051.334353221142;6055.666938318347;6079.513638908877;6083.513318934474;4872.756362181947;5046.116929537389;5070.264811602297;5090.945432740326;5124.641275110781;3189.186757376854;3214.2125179331215;3226.1450715560395;3246.5454836322933;3257.2345498808236;5440.945590544044;5671.120976248688;5674.00704876645;5683.175939488834;5696.433480792733;6075.2405949256345;6217.844553886099;6250.718717657716;6254.74981000764;6305.243370795534;5653.462921022497;5662.915056274242;5669.404712505293;5688.40271771458;5696.117101849137;6047.153398524122;6084.513238940963;6101.176341193882;6102.9694851525455;6119.632822030692;5929.110633405024;5944.762209511571;5993.430624090704;5998.550108741949;6008.669523176092;5648.491635752802;5651.88696226065;5657.688827114548;5663.178839068394;5684.806190699999;4039.4344791728595;4110.321796903478;4128.195001974586;4134.255833949918;4149.958500415078;6113.816585502442;6114.816555503342;6124.38756124384;6134.760812303566;6135.478484328882;5800.216970708901;5867.765289388377;5925.851853703692;5928.792492262923;5943.494802941798;5692.658440493584;5828.825135245949;5859.970700146472;5885.176075349369;5932.288125424977;5775.220345253337;5798.652080875161;5810.5061069809535;5814.418558144321;5824.330202026821;5850.795222167204;5936.762529498772;5950.880982380415;5968.134620480093;5971.940280597139;5738.799142030009;5765.048766953406;5778.56660750437;5802.709864506842;5803.332616749128 04:46:49 INFO - PID 28795 | |5;yui.html;701.863136688346;724.0225695311327;733.622184574944;746.5446077892485;747.9588622625757;11759.882401175986;12370.134090613661;13250.933745331273;14155.504557340495;14166.150030998122;15001.699966000673;15528.611784705388;15573.29920153593;15609.063456192636;15727.685446291067;883.2933653077529;902.2150728865896;905.1039470923771;909.172652885874;913.9817203655923;592.6444133519897;596.8507873031742;598.0461164442729;598.4853026397295;599.241958921964;963.9855402168973;965.0735294117655;968.559305515992;969.1132613658494;969.2875736333789;950.8716323296336;952.1002652493396;953.3183773601874;957.0190554681437;957.6121670723368;705.6789160931816;709.2588245283639;710.069808550795;710.3180946291566;711.4059760100322;13886.4445422183;13944.16335019902;13959.581212563638;14409.423623055065;14449.711005779931;13692.31538423075;14011.369488372946;14104.717905641932;14251.643708907257;14284.214368209745;12441.440135193938;12765.42555585001;12897.35513224335;12900.741985160244;12963.28701921394;3044.1172060102544;3050.9542356864663;3056.862441190152;3063.5404689296784;3068.7238148566735;63875.68062159659;64491.71916023558;65444.67277663581;66718.99607529407;66990;11865.347405892759;12327.50689972391;12423.378831058411;12477;12866.614001579968;19228.903855480912;19685.01574921248;19860.304889328803;20824.27115050966;20916.26793062266;6281.7173227204885;6399.104125422445;6535.444487218545;6574.145361103026;6591.505637077238;3036.104349216942;3064.050144455226;3070.370574032318;3088.3051313454293;3090.799098058619;3370.4607262837826;3464.1166502542196;3470.236547959445;3488.3720930232803;3583.3191693578137;726.1358982810439;733.4022771441258;733.7321877514669;734.1227233455969;736.0578459571757;563.8533981164844;593.4155804003321;597.9282486101608;604.8336707405499;611.3702886027398;9859.274626940256;9976.700698979042;10251.84622230667;10801.297915635458;10837.295575787548;595.1756816808751;607.3774381259244;607.6050567131311;613.2977740487117;620.8913440147955;4289.571042895685;4426.380306757057;4446.333050042519;4451.087527056946;4517.593416592523;55057;56039.43960560424;58243.417565824646;63721.36278637247;64422;49726;49988;50114;52396.73801631044;52598;46311.536884631394;46979;47145.528544714114;47556.5244347559;47631.5236847634;9929.503524823875;10409.84385234207;10559.15526757873;10625.840612390975;10892.61875834342;24350.63474047926;24628.384290392885;25051.498970020133;25259.863306151634;25557.616635750852;42942.57057429511;43155.352669709355;44049;44134.55865441304;44456.555434446534;12871.806922896352;13071.542496012595;13108.279044652636;13286.734265314833;13404.932975335061;15338.233088345762;15412.152331621868;15626.218689065274;15647.921760391126;15872.92063539675;13384.665383365495;13870.65323366924;14262.714745705236;14670.413183472541;14737.631559211106;14781.408743650134;14874;14881.255937203314;14882.10707357562;14966.326515307055;13402.128861623964;13506.864931350561;13625.659358516117;13688.794668080185;14183.64540886486;10056.547455364673;10192;10267.024632659886;10310.226732995205;10569.207309451976;11082.833757493805;11561.42192890369;11624.360660163773;11686.474108664961;11755.823662645238 04:46:49 INFO - PID 28795 | __end_tp_report 04:46:49 INFO - PID 28795 | __start_cc_report 04:46:49 INFO - PID 28795 | _x_x_mozilla_cycle_collect,264 04:46:49 INFO - PID 28795 | __end_cc_report 04:46:49 INFO - PID 28795 | __startTimestamp1495453609055__endTimestamp 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | ------- Summary: start ------- 04:46:49 INFO - PID 28795 | Number of tests: 6 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | [#0] dojo.html Cycles:165 Average:5170.92 Median:5323.12 stddev:616.47 (11.6%) stddev-sans-first:586.63 04:46:49 INFO - PID 28795 | Values: 2682.0 2699.3 2716.9 2737.6 2743.0 5154.1 5155.6 5219.7 5226.3 5249.7 5189.3 5283.2 5296.0 5304.4 5309.2 4646.9 4650.3 4686.3 4687.9 4723.3 4601.3 4667.8 4681.5 4685.5 4741.5 4644.6 4674.5 4692.5 4693.7 4698.6 4605.3 4616.1 4621.4 4648.5 4677.5 4542.3 4590.5 4592.4 4654.9 4666.8 5080.2 5115.6 5133.4 5138.2 5171.4 5482.1 5632.0 5639.9 5643.9 5656.2 5710.5 5729.9 5732.5 5732.9 5746.9 5310.6 5319.9 5329.8 5330.0 5331.9 5750.4 5855.3 5882.3 5892.9 5918.6 5516.1 5592.6 5602.0 5619.9 5671.5 5553.6 5668.5 5672.9 5683.3 5696.0 5599.6 5609.3 5615.7 5660.2 5664.8 5593.2 5600.0 5633.2 5643.4 5673.0 4671.2 4744.3 4767.8 4770.5 4794.6 3949.3 3996.5 4014.1 4044.1 4080.0 4854.8 4865.3 4866.8 4867.3 4923.0 5698.7 5711.5 5713.5 5722.7 5737.2 4734.7 4785.3 4832.4 4836.1 4841.2 5010.5 5016.1 5025.4 5025.9 5056.2 5237.5 5238.3 5252.9 5273.1 5279.9 5567.2 5646.6 5690.7 5698.9 5701.9 5226.6 5282.9 5287.8 5294.2 5323.1 5589.3 5599.5 5605.4 5607.1 5611.0 5559.8 5645.1 5655.4 5662.3 5665.0 5464.1 5497.8 5510.8 5512.1 5558.1 5374.9 5488.7 5511.3 5550.6 5579.8 5231.6 5335.2 5415.3 5518.3 5518.6 5443.4 5559.8 5573.2 5575.8 5596.5 5363.2 5399.6 5400.0 5421.0 5449.5 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | [#1] ext.html Cycles:180 Average:30305.97 Median:31490.53 stddev:41907.74 (133.1%) stddev-sans-first:41966.26 04:46:49 INFO - PID 28795 | Values: 680.5 722.6 744.5 912.8 929.6 32903.8 33741.7 33849.2 33903.3 33990.8 34632.5 35135.0 35193.6 35261.5 35335.8 6621.0 6771.7 6933.8 7075.6 7092.0 7018.3 7096.1 7104.9 7126.1 7148.5 7009.2 7102.5 7128.5 7159.1 7170.0 7122.8 7126.5 7136.0 7136.1 7141.6 7014.0 7016.2 7026.4 7053.8 7058.5 30981.1 31419.8 31459.0 31480.2 31500.8 2872.7 2875.6 2894.1 2895.7 2898.7 24542.9 24624.1 24626.6 24636.6 24692.5 2958.1 2970.3 2979.6 2982.5 2990.0 138521.2 139945.0 140308.0 148654.0 151344.2 38450.6 39148.8 39159.8 39196.4 39298.2 40976.4 41016.4 41035.6 41090.4 41099.6 9673.8 9919.7 9936.1 9946.7 9950.1 7768.7 7825.1 7866.2 7872.1 7874.3 10799.5 10824.8 10915.0 10988.4 11038.7 4659.0 4688.6 4693.9 4780.2 4797.0 868.9 882.4 890.2 894.9 904.1 20144.2 21063.3 21249.8 21313.0 21619.9 947.7 950.5 963.0 966.3 981.5 10827.7 11078.7 11333.2 11351.8 11378.4 179078.0 179268.0 179939.0 179980.1 180224.1 40793.4 41356.8 41406.6 41535.2 41688.4 1181.7 1226.1 1230.3 1231.1 1233.1 18333.2 18476.0 18934.7 19012.4 19016.8 26172.5 26200.6 31988.2 32762.8 32807.3 159445.2 159717.0 160143.0 161659.0 161749.0 29681.1 29695.9 30015.8 30191.8 30313.8 35860.6 35995.5 36026.3 36159.3 36532.8 27692.0 27982.9 28049.4 28277.3 28602.3 27053.6 27570.5 27675.7 28425.3 29032.6 29232.0 30039.1 30068.2 30189.0 30335.2 26568.3 26944.6 27039.3 27229.3 27818.9 21066.5 22098.1 22462.6 22507.7 22571.8 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | [#2] jquery.html Cycles:180 Average:24412.14 Median:37554.62 stddev:60602.62 (161.4%) stddev-sans-first:60745.81 04:46:49 INFO - PID 28795 | Values: 398.2 410.7 416.8 419.3 438.1 15731.4 16101.8 16411.8 16432.3 17332.0 16249.9 16254.3 16477.8 16510.3 16544.8 5250.7 5400.2 5448.9 5457.5 5469.3 5227.0 5344.7 5357.1 5357.1 5357.4 5343.9 5350.5 5351.0 5367.1 5371.8 5244.2 5458.3 5480.8 5486.8 5490.0 4823.9 4839.5 4918.3 4934.3 4939.8 22105.8 22470.8 22577.9 22604.8 22716.3 1626.5 1660.8 1668.5 1672.1 1674.3 14162.8 14733.2 15122.9 15170.2 15206.1 1993.7 2002.5 2035.4 2047.8 2053.7 90198.5 90692.0 92426.5 92556.1 93150.5 10223.7 10355.5 10597.9 10834.5 11030.9 14198.7 14316.3 14422.7 14424.6 14513.1 7231.3 7368.7 7476.7 7610.7 7622.3 6720.5 6753.4 6775.1 6932.4 7004.6 6873.2 6914.9 7008.5 7038.8 7045.8 1966.2 1974.5 2021.1 2023.2 2190.9 823.9 848.5 855.3 860.0 871.7 16355.3 16821.3 17492.4 17679.3 17748.1 855.0 866.1 867.6 871.1 896.6 9102.3 9203.4 9410.0 9551.8 9567.7 358738.0 360779.0 361069.0 365201.0 372742.0 69075.7 71975.0 73070.6 73625.6 74483.0 1026.8 1048.3 1069.9 1072.7 1076.6 14122.0 14155.2 14289.6 14428.9 14919.7 37462.6 37646.6 37909.6 38391.4 38471.2 46189.3 47187.8 47707.5 47989.5 48070.5 7671.0 7805.9 7858.4 7922.4 8022.9 11670.4 11699.0 11705.2 11856.5 12368.4 10389.6 10487.2 10680.8 10705.3 11466.5 10837.3 10990.9 11008.7 11033.3 11099.3 11616.9 11631.0 11943.5 12125.8 12213.2 7759.7 7947.0 7975.7 8059.1 8192.0 11135.8 11330.8 11343.3 11356.5 11733.7 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | [#3] mootools.html Cycles:180 Average:6007.49 Median:4605.38 stddev:3814.41 (82.8%) stddev-sans-first:3808.31 04:46:49 INFO - PID 28795 | Values: 1243.9 1298.6 1303.3 1311.2 1323.3 9331.6 9748.3 9755.0 9829.9 10077.7 9930.1 10065.8 10103.7 10104.6 10113.9 2221.2 2259.7 2276.5 2282.3 2285.8 2156.8 2176.2 2198.2 2199.2 2201.7 2186.4 2193.4 2221.0 2223.6 2245.0 2101.9 2146.1 2189.7 2192.7 2195.3 2038.1 2157.5 2170.7 2173.4 2176.3 9185.5 9193.2 9203.9 9224.8 9259.1 5273.4 5469.9 5491.7 5510.5 5521.5 3105.4 3332.1 3366.9 3375.7 3390.7 1032.9 1063.5 1064.7 1069.0 1082.5 14012.6 14170.0 14205.6 14251.8 14322.2 4538.5 4672.3 4827.1 4899.8 4910.2 10017.5 10051.6 10065.6 10080.2 10101.4 5343.3 5345.7 5352.3 5369.9 5373.4 4862.5 4960.6 5031.1 5032.9 5034.1 3779.2 3788.8 3818.0 3895.3 4011.9 1070.1 1072.6 1079.6 1082.5 1087.4 611.5 637.0 641.5 660.8 672.0 5082.3 5260.6 5264.2 5339.1 5406.2 776.4 802.3 802.5 804.9 824.8 3025.3 3029.7 3038.1 3095.9 3168.5 12303.8 12698.2 12817.6 12844.8 12867.5 12627.4 12692.6 12733.0 12755.5 12763.3 6812.0 6956.3 7035.2 7087.9 7095.5 5674.7 5744.2 5831.4 5900.8 5905.5 10914.2 11406.8 11504.9 11641.5 11701.6 11266.7 11350.5 11424.9 11449.3 11451.8 8003.8 8120.7 8197.8 8260.1 8329.8 8693.6 8918.7 8920.3 8932.1 9003.8 7519.9 7742.5 8001.2 8047.6 8126.8 7713.6 7747.7 7890.7 7981.2 8019.4 7004.2 7088.6 7123.4 7152.0 7161.0 4776.2 4928.1 5016.3 5048.1 5071.3 5046.2 5067.6 5111.3 5117.4 5117.4 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | [#4] prototype.html Cycles:180 Average:4806.87 Median:5483.19 stddev:1450.38 (26.5%) stddev-sans-first:1415.57 04:46:49 INFO - PID 28795 | Values: 363.0 371.2 379.7 384.6 387.3 5465.2 5512.7 5552.2 5571.3 5663.4 5364.3 5472.5 5475.5 5480.5 5485.9 3996.8 4117.4 4126.7 4143.1 4145.3 4124.3 4138.9 4140.6 4148.0 4153.7 4108.0 4114.3 4128.9 4134.8 4137.1 4024.8 4089.9 4097.4 4099.7 4107.4 3590.9 3591.8 3593.6 3594.8 3595.0 5377.2 5383.7 5398.4 5401.5 5411.2 4736.9 4845.4 4874.7 4882.5 4882.8 5764.8 5819.1 5832.2 5838.8 5853.7 3957.3 3988.3 4002.0 4003.0 4003.1 6040.8 6114.0 6174.7 6187.6 6218.9 4114.5 4118.3 4122.0 4125.2 4125.4 4146.3 4158.5 4163.4 4164.1 4186.7 4618.3 4811.3 4830.0 4836.8 4845.7 5811.7 5826.6 5831.9 5834.2 5849.5 1422.5 1428.8 1435.2 1437.1 1438.4 883.5 930.7 932.7 943.7 950.8 5062.9 5070.9 5087.3 5093.6 5101.6 6007.4 6051.3 6055.7 6079.5 6083.5 4872.8 5046.1 5070.3 5090.9 5124.6 3189.2 3214.2 3226.1 3246.5 3257.2 5440.9 5671.1 5674.0 5683.2 5696.4 6075.2 6217.8 6250.7 6254.7 6305.2 5653.5 5662.9 5669.4 5688.4 5696.1 6047.2 6084.5 6101.2 6103.0 6119.6 5929.1 5944.8 5993.4 5998.6 6008.7 5648.5 5651.9 5657.7 5663.2 5684.8 4039.4 4110.3 4128.2 4134.3 4150.0 6113.8 6114.8 6124.4 6134.8 6135.5 5800.2 5867.8 5925.9 5928.8 5943.5 5692.7 5828.8 5860.0 5885.2 5932.3 5775.2 5798.7 5810.5 5814.4 5824.3 5850.8 5936.8 5950.9 5968.1 5971.9 5738.8 5765.0 5778.6 5802.7 5803.3 04:46:49 INFO - PID 28795 | 04:46:49 INFO - PID 28795 | [#5] yui.html Cycles:180 Average:14870.74 Median:3089.55 stddev:17008.70 (550.5%) stddev-sans-first:17023.13 04:46:49 INFO - PID 28795 | Values: 701.9 724.0 733.6 746.5 748.0 11759.9 12370.1 13250.9 14155.5 14166.2 15001.7 15528.6 15573.3 15609.1 15727.7 883.3 902.2 905.1 909.2 914.0 592.6 596.9 598.0 598.5 599.2 964.0 965.1 968.6 969.1 969.3 950.9 952.1 953.3 957.0 957.6 705.7 709.3 710.1 710.3 711.4 13886.4 13944.2 13959.6 14409.4 14449.7 13692.3 14011.4 14104.7 14251.6 14284.2 12441.4 12765.4 12897.4 12900.7 12963.3 3044.1 3051.0 3056.9 3063.5 3068.7 63875.7 64491.7 65444.7 66719.0 66990.0 11865.3 12327.5 12423.4 12477.0 12866.6 19228.9 19685.0 19860.3 20824.3 20916.3 6281.7 6399.1 6535.4 6574.1 6591.5 3036.1 3064.1 3070.4 3088.3 3090.8 3370.5 3464.1 3470.2 3488.4 3583.3 726.1 733.4 733.7 734.1 736.1 563.9 593.4 597.9 604.8 611.4 9859.3 9976.7 10251.8 10801.3 10837.3 595.2 607.4 607.6 613.3 620.9 4289.6 4426.4 4446.3 4451.1 4517.6 55057.0 56039.4 58243.4 63721.4 64422.0 49726.0 49988.0 50114.0 52396.7 52598.0 46311.5 46979.0 47145.5 47556.5 47631.5 9929.5 10409.8 10559.2 10625.8 10892.6 24350.6 24628.4 25051.5 25259.9 25557.6 42942.6 43155.4 44049.0 44134.6 44456.6 12871.8 13071.5 13108.3 13286.7 13404.9 15338.2 15412.2 15626.2 15647.9 15872.9 13384.7 13870.7 14262.7 14670.4 14737.6 14781.4 14874.0 14881.3 14882.1 14966.3 13402.1 13506.9 13625.7 13688.8 14183.6 10056.5 10192.0 10267.0 10310.2 10569.2 11082.8 11561.4 11624.4 11686.5 11755.8 04:46:49 INFO - PID 28795 | -------- Summary: end -------- 04:46:49 INFO - PID 28795 | 04:46:49 INFO - TEST-INFO | 28795: exit 0 04:46:49 INFO - TEST-OK | dromaeo_css | took 1117494ms 04:46:49 INFO - TEST-START | kraken 04:46:49 INFO - operating with platform_type : linux_ 04:46:49 INFO - Initialising browser for kraken test... 04:46:49 INFO - TEST-INFO | started process 29201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJxNcR/profile http://localhost:43740/getInfo.html) 04:46:50 INFO - PID 29201 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:46:53 INFO - PID 29201 | __metrics Screen width/height:1600/1200 04:46:53 INFO - PID 29201 | colorDepth:24 04:46:53 INFO - PID 29201 | Browser inner width/height: 1024/695 04:46:53 INFO - PID 29201 | __metrics 04:46:55 INFO - TEST-INFO | 29201: exit 0 04:46:55 INFO - Browser initialized. 04:46:55 INFO - Running cycle 1/1 for kraken test... 04:46:55 INFO - TEST-INFO | started process 29364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJxNcR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:07 INFO - PID 29364 | RSS: Main: 166453248 04:47:07 INFO - PID 29364 | 04:47:09 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:11 INFO - PID 29364 | RSS: Main: 170868736 04:47:11 INFO - PID 29364 | 04:47:13 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-dft) 04:47:14 INFO - PID 29364 | RSS: Main: 171388928 04:47:14 INFO - PID 29364 | 04:47:17 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-fft) 04:47:17 INFO - PID 29364 | RSS: Main: 166100992 04:47:17 INFO - PID 29364 | 04:47:20 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-oscillator) 04:47:20 INFO - PID 29364 | RSS: Main: 166555648 04:47:20 INFO - PID 29364 | 04:47:22 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:23 INFO - PID 29364 | RSS: Main: 167129088 04:47:23 INFO - PID 29364 | 04:47:26 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:27 INFO - PID 29364 | RSS: Main: 171057152 04:47:27 INFO - PID 29364 | 04:47:30 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:31 INFO - PID 29364 | RSS: Main: 168726528 04:47:31 INFO - PID 29364 | 04:47:34 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43740/tests/kraken/driver.html?testName=json-parse-financial) 04:47:34 INFO - PID 29364 | RSS: Main: 169406464 04:47:34 INFO - PID 29364 | 04:47:36 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43740/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:36 INFO - PID 29364 | RSS: Main: 169365504 04:47:36 INFO - PID 29364 | 04:47:38 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:39 INFO - PID 29364 | RSS: Main: 169144320 04:47:39 INFO - PID 29364 | 04:47:41 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:42 INFO - PID 29364 | RSS: Main: 169144320 04:47:42 INFO - PID 29364 | 04:47:44 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:45 INFO - PID 29364 | RSS: Main: 169598976 04:47:45 INFO - PID 29364 | 04:47:48 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:49 INFO - PID 29364 | RSS: Main: 169603072 04:47:49 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43740/tests/kraken/driver.html?testName=ai-astar) 04:47:51 INFO - PID 29364 | RSS: Main: 170496000 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | __start_tp_report 04:47:51 INFO - PID 29364 | _x_x_mozilla_page_load 04:47:51 INFO - PID 29364 | _x_x_mozilla_page_load_details 04:47:51 INFO - PID 29364 | |i|pagename|runs| 04:47:51 INFO - PID 29364 | |0;ai-astar;104;112;112;114;110;112;113;114;112;112 04:47:51 INFO - PID 29364 | |1;audio-beat-detection;154;131;129;169;123;124;125;132;151;127 04:47:51 INFO - PID 29364 | |2;audio-dft;165;165;164;166;168;166;169;169;164;165 04:47:51 INFO - PID 29364 | |3;audio-fft;76;76;75;115;76;75;85;75;91;76 04:47:51 INFO - PID 29364 | |4;audio-oscillator;84;84;106;85;84;83;97;83;83;104 04:47:51 INFO - PID 29364 | |5;imaging-gaussian-blur;114;116;115;114;115;114;115;115;114;118 04:47:51 INFO - PID 29364 | |6;imaging-darkroom;150;150;151;151;151;151;151;150;152;150 04:47:51 INFO - PID 29364 | |7;imaging-desaturate;95;95;97;94;95;95;95;109;95;95 04:47:51 INFO - PID 29364 | |8;json-parse-financial;55;54;53;54;57;56;58;55;56;56 04:47:51 INFO - PID 29364 | |9;json-stringify-tinderbox;57;57;57;57;56;57;57;60;57;56 04:47:51 INFO - PID 29364 | |10;stanford-crypto-aes;83;83;91;94;84;82;84;82;85;83 04:47:51 INFO - PID 29364 | |11;stanford-crypto-ccm;137;136;135;132;133;142;139;143;179;133 04:47:51 INFO - PID 29364 | |12;stanford-crypto-pbkdf2;187;205;200;198;207;194;196;196;193;197 04:47:51 INFO - PID 29364 | |13;stanford-crypto-sha256-iterative;78;76;76;75;74;74;74;73;73;74 04:47:51 INFO - PID 29364 | __end_tp_report 04:47:51 INFO - PID 29364 | __start_cc_report 04:47:51 INFO - PID 29364 | _x_x_mozilla_cycle_collect,768 04:47:51 INFO - PID 29364 | __end_cc_report 04:47:51 INFO - PID 29364 | __startTimestamp1495453671623__endTimestamp 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | ------- Summary: start ------- 04:47:51 INFO - PID 29364 | Number of tests: 14 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.88 (2.6%) stddev-sans-first:1.22 04:47:51 INFO - PID 29364 | Values: 104.0 112.0 112.0 114.0 110.0 112.0 113.0 114.0 112.0 112.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:131.50 stddev:15.78 (12.0%) stddev-sans-first:15.41 04:47:51 INFO - PID 29364 | Values: 154.0 131.0 129.0 169.0 123.0 124.0 125.0 132.0 151.0 127.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:1.91 (1.2%) stddev-sans-first:1.99 04:47:51 INFO - PID 29364 | Values: 165.0 165.0 164.0 166.0 168.0 166.0 169.0 169.0 164.0 165.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.78 (16.8%) stddev-sans-first:13.37 04:47:51 INFO - PID 29364 | Values: 76.0 76.0 75.0 115.0 76.0 75.0 85.0 75.0 91.0 76.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:84.00 stddev:9.29 (11.1%) stddev-sans-first:9.65 04:47:51 INFO - PID 29364 | Values: 84.0 84.0 106.0 85.0 84.0 83.0 97.0 83.0 83.0 104.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 04:47:51 INFO - PID 29364 | Values: 114.0 116.0 115.0 114.0 115.0 114.0 115.0 115.0 114.0 118.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:47:51 INFO - PID 29364 | Values: 150.0 150.0 151.0 151.0 151.0 151.0 151.0 150.0 152.0 150.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:95.00 stddev:4.45 (4.7%) stddev-sans-first:4.69 04:47:51 INFO - PID 29364 | Values: 95.0 95.0 97.0 94.0 95.0 95.0 95.0 109.0 95.0 95.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 04:47:51 INFO - PID 29364 | Values: 55.0 54.0 53.0 54.0 57.0 56.0 58.0 55.0 56.0 56.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:1.10 (1.9%) stddev-sans-first:1.17 04:47:51 INFO - PID 29364 | Values: 57.0 57.0 57.0 57.0 56.0 57.0 57.0 60.0 57.0 56.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:4.07 (4.8%) stddev-sans-first:4.24 04:47:51 INFO - PID 29364 | Values: 83.0 83.0 91.0 94.0 84.0 82.0 84.0 82.0 85.0 83.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:138.00 stddev:13.90 (10.1%) stddev-sans-first:14.67 04:47:51 INFO - PID 29364 | Values: 137.0 136.0 135.0 132.0 133.0 142.0 139.0 143.0 179.0 133.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.30 Median:197.50 stddev:5.77 (2.9%) stddev-sans-first:4.77 04:47:51 INFO - PID 29364 | Values: 187.0 205.0 200.0 198.0 207.0 194.0 196.0 196.0 193.0 197.0 04:47:51 INFO - PID 29364 | 04:47:51 INFO - PID 29364 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:74.50 stddev:1.57 (2.1%) stddev-sans-first:1.12 04:47:51 INFO - PID 29364 | Values: 78.0 76.0 76.0 75.0 74.0 74.0 74.0 73.0 73.0 74.0 04:47:51 INFO - PID 29364 | -------- Summary: end -------- 04:47:51 INFO - PID 29364 | 04:47:52 INFO - TEST-INFO | 29364: exit 0 04:47:52 INFO - TEST-OK | kraken | took 62748ms 04:47:52 INFO - SUITE-END | took 1180s 04:47:52 INFO - Completed test suite (00:19:40) 04:47:52 INFO - javascript benchmark 04:47:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6613.0676547467665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.9999999999995, 2699.2981824725566, 2716.904908328209, 2737.575675770256, 2742.9725702742967, 5154.123798954178, 5155.639105262633, 5219.685499707689, 5226.29445024922, 5249.7375131243425, 5189.299444574981, 5283.233931080001, 5296.0, 5304.3634763828295, 5309.203619457084, 4646.86059418218, 4650.325702773096, 4686.250199968006, 4687.859364219079, 4723.267893476499, 4601.263797792354, 4667.789949452283, 4681.46163191234, 4685.5314468553215, 4741.525847415248, 4644.628429725648, 4674.509176536449, 4692.460367057798, 4693.718376897397, 4698.600618947394, 4605.332226827091, 4616.122936642061, 4621.4223222097235, 4648.48866624671, 4677.532246775329, 4542.273236282179, 4590.540945905416, 4592.380028696117, 4654.930176047362, 4666.813327466897, 5080.187170052774, 5115.565176959963, 5133.358330208724, 5138.229265610151, 5171.4311425743135, 5482.068048431736, 5632.014397480424, 5639.915401268984, 5643.943560564383, 5656.208130861683, 5710.457506536873, 5729.885402291972, 5732.541396688297, 5732.914006289909, 5746.9425305747245, 5310.60170487215, 5319.867003324948, 5329.786808527693, 5330.040592693353, 5331.86670333237, 5750.396208398141, 5855.2973643163095, 5882.294124704978, 5892.882142357214, 5918.615290006222, 5516.117421212587, 5592.608517403824, 5601.991641504568, 5619.943800562024, 5671.461211184931, 5553.583481238923, 5668.546516278688, 5672.858178545487, 5683.2895888014, 5695.971520142372, 5599.636023658531, 5609.270794796732, 5615.719214039364, 5660.2075709400715, 5664.773409063674, 5593.216949627055, 5600.047991841397, 5633.155026745939, 5643.435656434406, 5673.035583950656, 4671.229247174178, 4744.264638980894, 4767.833125840648, 4770.475247722748, 4794.5924596409695, 3949.328614135604, 3996.500437445319, 4014.136960553495, 4044.090079732037, 4080.020795009236, 4854.83008094722, 4865.294532292868, 4866.829660961849, 4867.294242334841, 4922.975385123052, 5698.686572238566, 5711.485966262973, 5713.514351280104, 5722.685252311079, 5737.225474560964, 4734.668573199843, 4785.3300537924715, 4832.395950506187, 4836.105320515646, 4841.176999910023, 5010.5240002199735, 5016.072026675077, 5025.422076461181, 5025.899482010339, 5056.241563765465, 5237.450067742984, 5238.266642669953, 5252.894942101213, 5273.129933560919, 5279.868003299948, 5567.220589117608, 5646.632968857011, 5690.658560486384, 5698.886022279448, 5701.942980570141, 5226.63413561047, 5282.9471705283995, 5287.788488460418, 5294.152935530296, 5323.121684922099, 5589.273394458694, 5599.468050535193, 5605.411431799603, 5607.130894711327, 5610.971945140412, 5559.833205003856, 5645.096784514458, 5655.406182350958, 5662.320521537442, 5664.971675141763, 5464.098423760035, 5497.835064948058, 5510.779568817203, 5512.118061110203, 5558.082916318762, 5374.946250537445, 5488.670679759227, 5511.283533140827, 5550.639208451437, 5579.77680892776, 5231.633785635121, 5335.1730481775385, 5415.296011518478, 5518.33779946409, 5518.558515318845, 5443.374011988672, 5559.777608895761, 5573.247611572386, 5575.804846830504, 5596.468335508121, 5363.222332761806, 5399.595030372816, 5400.0, 5421.024215641065, 5449.536789372948], "value": 5125.45655134977, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.5406350713267, 722.6025685872769, 744.4825846037003, 912.7991841794803, 929.5538141691992, 32903.83548082259, 33741.66258337416, 33849.153771155674, 33903.32193356132, 33990.83004584977, 34632.48051279233, 35135.0, 35193.648063519424, 35261.47107793385, 35335.82332088342, 6621.0, 6771.661416929134, 6933.791986240421, 7075.610841403746, 7092.0, 7018.33325834045, 7096.112985876765, 7104.85790284194, 7126.11158043119, 7148.463865210104, 7009.228984811667, 7102.538335008208, 7128.536645118051, 7159.105111861018, 7170.0, 7122.78631641049, 7126.501144919857, 7136.0, 7136.07231059964, 7141.571505709648, 7013.964930175367, 7016.158061032709, 7026.367626913602, 7053.788386348418, 7058.541194822372, 30981.070567882773, 31419.842900785578, 31459.0, 31480.212994675087, 31500.842495787605, 2872.6840047594746, 2875.5542890851953, 2894.1462268630803, 2895.6669982951807, 2898.666653334851, 24542.877285613635, 24624.138155164484, 24626.630600541008, 24636.630450543256, 24692.50614987708, 2958.097780177045, 2970.3316753730455, 2979.6424429068434, 2982.478066338404, 2989.9551506727416, 138521.22957540792, 139945.0, 140308.0, 148654.0, 151344.243278784, 38450.61549384526, 39148.80425597854, 39159.80420097881, 39196.412053819215, 39298.2140357197, 40976.38535421971, 41016.38475422871, 41035.58964410318, 41090.38364424536, 41099.589004110174, 9673.758156046155, 9919.65281215154, 9936.105750482491, 9946.651867184759, 9950.054744799232, 7768.728094516665, 7825.13923468418, 7866.174051724601, 7872.1340652529325, 7874.330681891989, 10799.514021869034, 10824.837627435594, 10915.0, 10988.395638239974, 11038.668839934815, 4659.0, 4688.64835137366, 4693.882652933636, 4780.163471392492, 4796.952030479721, 868.9435186712843, 882.4484697064335, 890.2032680750692, 894.8791913091779, 904.1094521895927, 20144.19423223084, 21063.262785802424, 21249.787502124782, 21313.040913158944, 21619.891900540395, 947.7156852944089, 950.5484894674975, 962.9537233379069, 966.2608104799833, 981.489625394805, 10827.729306767395, 11078.723031924104, 11333.150013749002, 11351.772964540663, 11378.431078446045, 179078.0, 179268.0, 179939.0, 179980.1000995013, 180224.09887950477, 40793.388099177944, 41356.79321603373, 41406.585934140276, 41535.169296614506, 41688.374674379906, 1181.7211603764465, 1226.1110694746417, 1230.317173968456, 1231.1074471008626, 1233.0813543909844, 18333.16668333156, 18475.9791279313, 18934.715979260047, 19012.429627111207, 19016.809831901504, 26172.476550469266, 26200.606990895532, 31988.20029499281, 32762.83618581892, 32807.34385312233, 159445.20277399002, 159717.0, 160143.0, 161659.0, 161749.0, 29681.109566713032, 29695.851520742257, 30015.849920750257, 30191.849040755533, 30313.848430757706, 35860.641393586775, 35995.46006809952, 36026.27947441089, 36159.27681446304, 36532.81733591315, 27692.0, 27982.86008569944, 28049.43901122007, 28277.293067673472, 28602.28494287576, 27053.59419608668, 27570.458446307464, 27675.723242767315, 28425.28936776597, 29032.56451153192, 29232.0, 30039.098827035225, 30068.248293791956, 30189.0, 30335.241618959702, 26568.33579160459, 26944.595831062943, 27039.324016899736, 27229.319267018484, 27818.860905695343, 21066.47333816667, 22098.116075357448, 22462.550748985257, 22507.662385064566, 22571.774282257626], "value": 14132.645756821401, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.2334007036456, 410.67966985751116, 416.7624454061186, 419.3207004652463, 438.11282153638876, 15731.449399271029, 16101.758473622906, 16411.83588164118, 16432.260548275328, 17332.0, 16249.918750406261, 16254.268557914893, 16477.83522164778, 16510.33958641653, 16544.75182872258, 5250.684958902459, 5400.243965844785, 5448.945510544883, 5457.536109430703, 5469.343678758534, 5226.973865130669, 5344.652597581165, 5357.1160758475, 5357.142857142858, 5357.4374690657505, 5343.946560534403, 5350.491703288201, 5351.0, 5367.114426119686, 5371.81198658047, 5244.239585260135, 5458.263134476834, 5480.835574932758, 5486.807961721321, 5490.039243132456, 4823.927641085386, 4839.516048395168, 4918.336024636664, 4934.309196712463, 4939.777710003023, 22105.778942210694, 22470.844789987754, 22577.88711056434, 22604.773952260595, 22716.318510444715, 1626.5039163055264, 1660.825613310597, 1668.5328108129622, 1672.105423598381, 1674.2716918140648, 14162.787558186532, 14733.189674567895, 15122.924385378003, 15170.24148792567, 15206.08763474195, 1993.7009448582683, 2002.4793553676004, 2035.4300795777206, 2047.754269487671, 2053.722747429108, 90198.5490072552, 90692.0, 92426.53786731091, 92556.07443925542, 93150.53424732901, 10223.693289201336, 10355.534000969974, 10597.9470102649, 10834.512446939907, 11030.944845275882, 14198.716025679429, 14316.284185790877, 14422.711545769025, 14424.567262982127, 14513.129212247299, 7231.349178573953, 7368.705251789976, 7476.70093196277, 7610.695572177051, 7622.2758837910305, 6720.495962802809, 6753.3921947025, 6775.085363475966, 6932.376086152271, 7004.614746188907, 6873.175218973655, 6914.9308506915295, 7008.5094043416475, 7038.753643622448, 7045.788626341218, 1966.193860517181, 1974.4767636576319, 2021.13091370712, 2023.1806118522022, 2190.912363505474, 823.8970128733908, 848.4739461533889, 855.341387131905, 859.9613017414231, 871.7210492642294, 16355.264013119438, 16821.32714691423, 17492.38776642837, 17679.292828286983, 17748.112594370228, 854.9658013679383, 866.1425189062783, 867.6182479708908, 871.1462766488877, 896.5696465696502, 9102.271818254523, 9203.40177888435, 9410.0, 9551.761205969906, 9567.660527526152, 358738.0, 360779.0, 361069.0, 365201.0, 372742.0, 69075.65462172657, 71975.0, 73070.63464682749, 73625.63187184029, 74483.0, 1026.830572955454, 1048.2976405808126, 1069.8983596558314, 1072.742541789965, 1076.612419528969, 14122.0, 14155.150690958575, 14289.571312860631, 14428.855711442751, 14919.701605967603, 37462.625373747, 37646.62353376431, 37909.62090379061, 38391.42412863753, 38471.23057538777, 46189.30716039329, 47187.764061180846, 47707.5229247717, 47989.5201047985, 48070.5192948066, 7670.961645191738, 7805.882911756442, 7858.410619203697, 7922.366210703015, 8022.879656805036, 11670.416479175838, 11699.0, 11705.180637355303, 11856.525738970344, 12368.44342004594, 10389.584416623251, 10487.16102711766, 10680.786384272427, 10705.304155229886, 11466.541338346373, 10837.349759014485, 10990.890091098987, 11008.669739907815, 11033.33799971972, 11099.334039957628, 11616.941915290707, 11631.0, 11943.522259109886, 12125.81811272814, 12213.206141600767, 7759.650815713419, 7947.0, 7975.680972761024, 8059.113497515152, 8192.0, 11135.83296250573, 11330.773384532427, 11343.262687925258, 11356.54573817038, 11733.706657333634], "value": 8651.797592043486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.894268987136, 1298.6363818130926, 1303.2636560343399, 1311.1805121798875, 1323.3317174826711, 9331.626734930604, 9748.268879834022, 9755.0, 9829.852552211723, 10077.748056298597, 9930.10629043386, 10065.798684026315, 10103.747406314846, 10104.595816167344, 10113.949430252856, 2221.1670623516184, 2259.7288325400973, 2276.4877902471976, 2282.2924893283052, 2285.759995200505, 2156.7519735230494, 2176.249194028058, 2198.175514323108, 2199.164317559333, 2201.6587428948537, 2186.3768825884626, 2193.352960876537, 2220.966685499711, 2223.621984262671, 2244.955100897981, 2101.9474513137143, 2146.0557354763855, 2189.7481789594162, 2192.7478339990867, 2195.2865318771464, 2038.0930485933618, 2157.514559224178, 2170.6526955687173, 2173.4240426287047, 2176.336217453676, 9185.540722963826, 9193.218576420946, 9203.907960920438, 9224.769380765467, 9259.074092590754, 5273.419923808378, 5469.863253418656, 5491.725413729338, 5510.531604813596, 5521.503064724154, 3105.4410206162884, 3332.100332910101, 3366.882159124443, 3375.7468189885612, 3390.7117894978956, 1032.8863824979246, 1063.4948399510172, 1064.6646306413531, 1069.0485467933545, 1082.5020490574345, 14012.579622611338, 14170.0, 14205.573832785032, 14251.78622320666, 14322.212278324792, 4538.500764915922, 4672.252439609646, 4827.058723548875, 4899.779509922062, 4910.165271903785, 10017.499125043865, 10051.59793608262, 10065.64770233053, 10080.193584513221, 10101.44442055694, 5343.278657381204, 5345.732713364317, 5352.330958630171, 5369.946300537023, 5373.38206106295, 4862.5380588844, 4960.627952903546, 5031.119554078022, 5032.924506132411, 5034.0686972910125, 3779.225258821935, 3788.791616461121, 3817.980910095487, 3895.3183192941688, 4011.8796436106963, 1070.0850772589479, 1072.6353039966448, 1079.5897558927713, 1082.4641802307908, 1087.374759513283, 611.5199568338833, 636.9649669268142, 641.5284765697209, 660.8116686744255, 672.0, 5082.313887625123, 5260.605454590921, 5264.210368444687, 5339.065663508871, 5406.243125962368, 776.4293244465314, 802.3380710913519, 802.5425507460691, 804.9154838741848, 824.8102936324678, 3025.2739342558066, 3029.681883402255, 3038.0885734279627, 3095.8761649533767, 3168.4772012618123, 12303.815442768366, 12698.174618649942, 12817.615471535868, 12844.807327890088, 12867.48530058806, 12627.43176557057, 12692.555760548337, 12733.0, 12755.489780408865, 12763.29801860888, 6811.999999999901, 6956.2695916928, 7035.226125126232, 7087.92912070883, 7095.50331476802, 5674.74463649145, 5744.167095771007, 5831.446012628793, 5900.793472228452, 5905.52755779528, 10914.23600347968, 11406.771864562828, 11504.94247528757, 11641.53433862636, 11701.590444334408, 11266.66200014001, 11350.489227984926, 11424.942875285571, 11449.255798373079, 11451.828222576834, 8003.83992320162, 8120.715774947848, 8197.754067377988, 8260.091389947222, 8329.791755205926, 8693.608787604699, 8918.73243802687, 8920.330975177018, 8932.106789321017, 9003.774905627411, 7519.924800751923, 7742.458027938215, 8001.239882211181, 8047.557384343917, 8126.75619731409, 7713.575753333621, 7747.651355688895, 7890.684372625031, 7981.2018798119725, 8019.398545109257, 7004.194517630538, 7088.582283543209, 7123.394511466376, 7152.034475345762, 7160.964195178991, 4776.21192503233, 4928.112939670894, 5016.322796422436, 5048.141815891381, 5071.340725705634, 5046.1673823818655, 5067.645264831426, 5111.309973153725, 5117.385913690232, 5117.411497677815], "value": 4554.494752531679, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.99637003629954, 371.1556209623107, 379.6981399787169, 384.56544105161163, 387.33958600586004, 5465.180222966547, 5512.6968016759065, 5552.222688823568, 5571.275734154565, 5663.405342439047, 5364.275822763926, 5472.50747432731, 5475.534579560732, 5480.520259529924, 5485.862853428656, 3996.840126394941, 4117.3618089196225, 4126.7111302208705, 4143.088520525487, 4145.2952997990415, 4124.319487284594, 4138.855140070098, 4140.5859414058505, 4148.0, 4153.667706583481, 4107.979460102695, 4114.341705327149, 4128.8761337159785, 4134.8139333729905, 4137.110521237933, 4024.75851448914, 4089.8773036808648, 4097.405876147972, 4099.651529619986, 4107.383892416146, 3590.8743193988084, 3591.7665351752053, 3593.586737525192, 3594.820258987066, 3595.0, 5377.247185394048, 5383.703896285702, 5398.352197736258, 5401.540869026137, 5411.241346562344, 4736.8578942631775, 4845.394325709286, 4874.65877388583, 4882.511748825089, 4882.780274887638, 5764.798232061899, 5819.127130930352, 5832.212651292064, 5838.824835254949, 5853.678047707374, 3957.34703773877, 3988.262171498282, 4002.0195052212393, 4003.0, 4003.1393250451, 6040.758369665208, 6114.0, 6174.722137503778, 6187.597806142587, 6218.906716399303, 4114.526829414655, 4118.279301122351, 4122.031322639177, 4125.23683118618, 4125.443065186221, 4146.253674338648, 4158.521769996429, 4163.417121602978, 4164.125533637909, 4186.727862688916, 4618.261078227468, 4811.326414302001, 4830.0, 4836.758162091881, 4845.733484658378, 5811.738471768781, 5826.592138550345, 5831.917657639669, 5834.154047663065, 5849.532037436995, 1422.5021242565226, 1428.7926701936847, 1435.2106341512126, 1437.1018113678952, 1438.4318194313187, 883.4964070479765, 930.7300882744064, 932.7015355086443, 943.6697155995485, 950.8431108867098, 5062.924056139161, 5070.93510362828, 5087.3386459759995, 5093.567046801063, 5101.591872650179, 6007.429294217042, 6051.334353221142, 6055.666938318347, 6079.513638908877, 6083.513318934474, 4872.756362181947, 5046.116929537389, 5070.264811602297, 5090.945432740326, 5124.641275110781, 3189.186757376854, 3214.2125179331215, 3226.1450715560395, 3246.5454836322933, 3257.2345498808236, 5440.945590544044, 5671.120976248688, 5674.00704876645, 5683.175939488834, 5696.433480792733, 6075.2405949256345, 6217.844553886099, 6250.718717657716, 6254.74981000764, 6305.243370795534, 5653.462921022497, 5662.915056274242, 5669.404712505293, 5688.40271771458, 5696.117101849137, 6047.153398524122, 6084.513238940963, 6101.176341193882, 6102.9694851525455, 6119.632822030692, 5929.110633405024, 5944.762209511571, 5993.430624090704, 5998.550108741949, 6008.669523176092, 5648.491635752802, 5651.88696226065, 5657.688827114548, 5663.178839068394, 5684.806190699999, 4039.4344791728595, 4110.321796903478, 4128.195001974586, 4134.255833949918, 4149.958500415078, 6113.816585502442, 6114.816555503342, 6124.38756124384, 6134.760812303566, 6135.478484328882, 5800.216970708901, 5867.765289388377, 5925.851853703692, 5928.792492262923, 5943.494802941798, 5692.658440493584, 5828.825135245949, 5859.970700146472, 5885.176075349369, 5932.288125424977, 5775.220345253337, 5798.652080875161, 5810.5061069809535, 5814.418558144321, 5824.330202026821, 5850.795222167204, 5936.762529498772, 5950.880982380415, 5968.134620480093, 5971.940280597139, 5738.799142030009, 5765.048766953406, 5778.56660750437, 5802.709864506842, 5803.332616749128], "value": 4353.058078829175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.863136688346, 724.0225695311327, 733.622184574944, 746.5446077892485, 747.9588622625757, 11759.882401175986, 12370.134090613661, 13250.933745331273, 14155.504557340495, 14166.150030998122, 15001.699966000673, 15528.611784705388, 15573.29920153593, 15609.063456192636, 15727.685446291067, 883.2933653077529, 902.2150728865896, 905.1039470923771, 909.172652885874, 913.9817203655923, 592.6444133519897, 596.8507873031742, 598.0461164442729, 598.4853026397295, 599.241958921964, 963.9855402168973, 965.0735294117655, 968.559305515992, 969.1132613658494, 969.2875736333789, 950.8716323296336, 952.1002652493396, 953.3183773601874, 957.0190554681437, 957.6121670723368, 705.6789160931816, 709.2588245283639, 710.069808550795, 710.3180946291566, 711.4059760100322, 13886.4445422183, 13944.16335019902, 13959.581212563638, 14409.423623055065, 14449.711005779931, 13692.31538423075, 14011.369488372946, 14104.717905641932, 14251.643708907257, 14284.214368209745, 12441.440135193938, 12765.42555585001, 12897.35513224335, 12900.741985160244, 12963.28701921394, 3044.1172060102544, 3050.9542356864663, 3056.862441190152, 3063.5404689296784, 3068.7238148566735, 63875.68062159659, 64491.71916023558, 65444.67277663581, 66718.99607529407, 66990.0, 11865.347405892759, 12327.50689972391, 12423.378831058411, 12477.0, 12866.614001579968, 19228.903855480912, 19685.01574921248, 19860.304889328803, 20824.27115050966, 20916.26793062266, 6281.7173227204885, 6399.104125422445, 6535.444487218545, 6574.145361103026, 6591.505637077238, 3036.104349216942, 3064.050144455226, 3070.370574032318, 3088.3051313454293, 3090.799098058619, 3370.4607262837826, 3464.1166502542196, 3470.236547959445, 3488.3720930232803, 3583.3191693578137, 726.1358982810439, 733.4022771441258, 733.7321877514669, 734.1227233455969, 736.0578459571757, 563.8533981164844, 593.4155804003321, 597.9282486101608, 604.8336707405499, 611.3702886027398, 9859.274626940256, 9976.700698979042, 10251.84622230667, 10801.297915635458, 10837.295575787548, 595.1756816808751, 607.3774381259244, 607.6050567131311, 613.2977740487117, 620.8913440147955, 4289.571042895685, 4426.380306757057, 4446.333050042519, 4451.087527056946, 4517.593416592523, 55057.0, 56039.43960560424, 58243.417565824646, 63721.36278637247, 64422.0, 49726.0, 49988.0, 50114.0, 52396.73801631044, 52598.0, 46311.536884631394, 46979.0, 47145.528544714114, 47556.5244347559, 47631.5236847634, 9929.503524823875, 10409.84385234207, 10559.15526757873, 10625.840612390975, 10892.61875834342, 24350.63474047926, 24628.384290392885, 25051.498970020133, 25259.863306151634, 25557.616635750852, 42942.57057429511, 43155.352669709355, 44049.0, 44134.55865441304, 44456.555434446534, 12871.806922896352, 13071.542496012595, 13108.279044652636, 13286.734265314833, 13404.932975335061, 15338.233088345762, 15412.152331621868, 15626.218689065274, 15647.921760391126, 15872.92063539675, 13384.665383365495, 13870.65323366924, 14262.714745705236, 14670.413183472541, 14737.631559211106, 14781.408743650134, 14874.0, 14881.255937203314, 14882.10707357562, 14966.326515307055, 13402.128861623964, 13506.864931350561, 13625.659358516117, 13688.794668080185, 14183.64540886486, 10056.547455364673, 10192.0, 10267.024632659886, 10310.226732995205, 10569.207309451976, 11082.833757493805, 11561.42192890369, 11624.360660163773, 11686.474108664961, 11755.823662645238], "value": 6731.153372920737, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 114.0, 110.0, 112.0, 113.0, 114.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 129.0, 169.0, 123.0, 124.0, 125.0, 132.0, 151.0, 127.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 166.0, 168.0, 166.0, 169.0, 169.0, 164.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 115.0, 76.0, 75.0, 85.0, 75.0, 91.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 85.0, 84.0, 83.0, 97.0, 83.0, 83.0, 104.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 118.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0, 150.0, 152.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 94.0, 95.0, 95.0, 95.0, 109.0, 95.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 57.0, 56.0, 58.0, 55.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 60.0, 57.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 91.0, 94.0, 84.0, 82.0, 84.0, 82.0, 85.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 132.0, 133.0, 142.0, 139.0, 143.0, 179.0, 133.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 205.0, 200.0, 198.0, 207.0, 194.0, 196.0, 196.0, 193.0, 197.0], "value": 197.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 75.0, 74.0, 74.0, 74.0, 73.0, 73.0, 74.0], "value": 74.7, "unit": "score"}]}]} 04:47:52 INFO - Return code: 0 04:47:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:52 INFO - # TBPL SUCCESS # 04:47:52 INFO - Running post-action listener: _resource_record_post_action 04:47:52 INFO - [mozharness: 2017-05-22 11:47:52.903553Z] Finished run-tests step (success) 04:47:52 INFO - Running post-run listener: _resource_record_post_run 04:47:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409714688; Read time: 12; Write time: 265916 04:47:52 INFO - TinderboxPrint: CPU usage
13.3% 04:47:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:47:52 INFO - TinderboxPrint: I/O write bytes / time
409,714,688 / 265,916 04:47:52 INFO - TinderboxPrint: CPU idle
8,276.3 (86.7%) 04:47:52 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 04:47:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 85975040; Read time: 0; Write time: 76108 04:47:52 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309198848; Read time: 12; Write time: 182612 04:47:53 INFO - Running post-run listener: _upload_blobber_files 04:47:53 INFO - Blob upload gear active. 04:47:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:53 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 04:47:53 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'] 04:47:53 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 04:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:54 INFO - (blobuploader) - INFO - Done attempting. 04:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:47:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:55 INFO - (blobuploader) - INFO - Done attempting. 04:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:01 INFO - (blobuploader) - INFO - Done attempting. 04:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:02 INFO - (blobuploader) - INFO - Done attempting. 04:48:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:02 INFO - Return code: 0 04:48:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df904f3a0de569001e4c290bc10e134182d74832cbca1aa8da966c086ef9c809da85a8f8daeaf7c9ba849e5a2b1871c0c146861377e859f1b6585ef0d3cb5fc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6274ccd6ef937da5baeff30dad22dc8ff042717ea56bcc50a2610e17c454d46c4f2dbcc8ad501f9895c6b0b4a859cb47a1386bbb08e8c55cb116c78b2ed2ab", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/335d22a65202fa43b7ebc9da751f03c9bd5244c60017ab1ac413c843baf188d84100b62e2d47af00c992137a2f13076e2e2f12f2ea7652d6ee7d03104cc846af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7365c0e712cd9fad43dc43369ece00fc4baec22126d4a4d0aa7ed52cdb9622e1273ecd2b69fbc62e54d546e80248b34d9f302488fc539eaa23a4c591f9b712d"} 04:48:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:02 INFO - Contents: 04:48:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df904f3a0de569001e4c290bc10e134182d74832cbca1aa8da966c086ef9c809da85a8f8daeaf7c9ba849e5a2b1871c0c146861377e859f1b6585ef0d3cb5fc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6274ccd6ef937da5baeff30dad22dc8ff042717ea56bcc50a2610e17c454d46c4f2dbcc8ad501f9895c6b0b4a859cb47a1386bbb08e8c55cb116c78b2ed2ab", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/335d22a65202fa43b7ebc9da751f03c9bd5244c60017ab1ac413c843baf188d84100b62e2d47af00c992137a2f13076e2e2f12f2ea7652d6ee7d03104cc846af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7365c0e712cd9fad43dc43369ece00fc4baec22126d4a4d0aa7ed52cdb9622e1273ecd2b69fbc62e54d546e80248b34d9f302488fc539eaa23a4c591f9b712d"} 04:48:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:02 INFO - Copying logs to upload dir... 04:48:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.831611 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-05-22 04:48:00.933855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 04:48:00.937320) ========= 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=6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227 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/df904f3a0de569001e4c290bc10e134182d74832cbca1aa8da966c086ef9c809da85a8f8daeaf7c9ba849e5a2b1871c0c146861377e859f1b6585ef0d3cb5fc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6274ccd6ef937da5baeff30dad22dc8ff042717ea56bcc50a2610e17c454d46c4f2dbcc8ad501f9895c6b0b4a859cb47a1386bbb08e8c55cb116c78b2ed2ab", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/335d22a65202fa43b7ebc9da751f03c9bd5244c60017ab1ac413c843baf188d84100b62e2d47af00c992137a2f13076e2e2f12f2ea7652d6ee7d03104cc846af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7365c0e712cd9fad43dc43369ece00fc4baec22126d4a4d0aa7ed52cdb9622e1273ecd2b69fbc62e54d546e80248b34d9f302488fc539eaa23a4c591f9b712d"} build_url:https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/RhFYWNzWT6ae80C-QxBHVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df904f3a0de569001e4c290bc10e134182d74832cbca1aa8da966c086ef9c809da85a8f8daeaf7c9ba849e5a2b1871c0c146861377e859f1b6585ef0d3cb5fc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6274ccd6ef937da5baeff30dad22dc8ff042717ea56bcc50a2610e17c454d46c4f2dbcc8ad501f9895c6b0b4a859cb47a1386bbb08e8c55cb116c78b2ed2ab", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/335d22a65202fa43b7ebc9da751f03c9bd5244c60017ab1ac413c843baf188d84100b62e2d47af00c992137a2f13076e2e2f12f2ea7652d6ee7d03104cc846af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7365c0e712cd9fad43dc43369ece00fc4baec22126d4a4d0aa7ed52cdb9622e1273ecd2b69fbc62e54d546e80248b34d9f302488fc539eaa23a4c591f9b712d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 04:48:00.975948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:48:00.976518) ========= 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=6dbc10da6d83fee962c624be000001a8-1495452116.54963-469165227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:48:01.053934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 04:48:01.054487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 04:48:01.056669) ========= ========= Total master_lag: 0.19 =========