builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1479488595.88 results: success (0) buildid: 20161118074928 builduid: bc1731146fac4991b29c8a60d76a2f4c revision: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:15.879581) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:15.879993) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:15.880311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:15.895041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:15.895367) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 09:03:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-11-18 09:03:16 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.030287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.030867) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016217 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.081998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.082525) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 09:03:16,917 truncating revision to first 12 chars 2016-11-18 09:03:16,917 Setting DEBUG logging. 2016-11-18 09:03:16,917 attempt 1/10 2016-11-18 09:03:16,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6186126f502b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 09:03:17,233 unpacking tar archive at: mozilla-central-6186126f502b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.704606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.704964) ========= script_repo_revision: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.705407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.705681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 09:03:16.716304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-18 09:03:16.716768) ========= /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=6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:17 INFO - MultiFileLogger online at 20161118 09:03:17 in /builds/slave/test 09:03:17 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 09:03:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:03:17 INFO - {'append_to_log': False, 09:03:17 INFO - 'base_work_dir': '/builds/slave/test', 09:03:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:03:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:03:17 INFO - 'branch': 'Firefox-Non-PGO', 09:03:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:17 INFO - 'config_files': ('talos/linux_config.py',), 09:03:17 INFO - 'default_actions': ('clobber', 09:03:17 INFO - 'read-buildbot-config', 09:03:17 INFO - 'download-and-extract', 09:03:17 INFO - 'populate-webroot', 09:03:17 INFO - 'create-virtualenv', 09:03:17 INFO - 'install', 09:03:17 INFO - 'run-tests'), 09:03:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:17 INFO - 'download_minidump_stackwalk': True, 09:03:17 INFO - 'download_symbols': 'ondemand', 09:03:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:17 INFO - 'installer_path': 'installer.exe', 09:03:17 INFO - 'log_level': 'info', 09:03:17 INFO - 'log_name': 'talos', 09:03:17 INFO - 'log_to_console': True, 09:03:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:17 INFO - 'opt_config_files': (), 09:03:17 INFO - 'pip_index': False, 09:03:17 INFO - 'sps_profile': False, 09:03:17 INFO - 'sps_profile_interval': 0, 09:03:17 INFO - 'suite': 'dromaeojs-e10s', 09:03:17 INFO - 'system_bits': '32', 09:03:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:17 INFO - 'title': 'talos-linux64-ix-023', 09:03:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:17 INFO - 'use_talos_json': True, 09:03:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:03:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:17 INFO - 'work_dir': 'build'} 09:03:17 INFO - [mozharness: 2016-11-18 17:03:17.643353Z] Running clobber step. 09:03:17 INFO - Running pre-action listener: _resource_record_pre_action 09:03:17 INFO - Running main action method: clobber 09:03:17 INFO - rmtree: /builds/slave/test/build 09:03:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:03:18 INFO - Running post-action listener: _resource_record_post_action 09:03:18 INFO - [mozharness: 2016-11-18 17:03:18.096961Z] Finished clobber step (success) 09:03:18 INFO - [mozharness: 2016-11-18 17:03:18.097059Z] Running read-buildbot-config step. 09:03:18 INFO - Running pre-action listener: _resource_record_pre_action 09:03:18 INFO - Running main action method: read_buildbot_config 09:03:18 INFO - Using buildbot properties: 09:03:18 INFO - { 09:03:18 INFO - "project": "", 09:03:18 INFO - "product": "firefox", 09:03:18 INFO - "script_repo_revision": "production", 09:03:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:03:18 INFO - "repository": "", 09:03:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:03:18 INFO - "buildid": "20161118074928", 09:03:18 INFO - "pgo_build": "False", 09:03:18 INFO - "basedir": "/builds/slave/test", 09:03:18 INFO - "buildnumber": 541, 09:03:18 INFO - "slavename": "talos-linux64-ix-023", 09:03:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:03:18 INFO - "platform": "ubuntu64_hw", 09:03:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:03:18 INFO - "branch": "mozilla-central", 09:03:18 INFO - "repo_path": "mozilla-central", 09:03:18 INFO - "revision": "6186126f502ba47e4fb2b6f4d971ea6fd3e66a02", 09:03:18 INFO - "stage_platform": "linux64", 09:03:18 INFO - "builduid": "bc1731146fac4991b29c8a60d76a2f4c", 09:03:18 INFO - "slavebuilddir": "test" 09:03:18 INFO - } 09:03:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:03:18 INFO - Running post-action listener: _resource_record_post_action 09:03:18 INFO - [mozharness: 2016-11-18 17:03:18.099712Z] Finished read-buildbot-config step (success) 09:03:18 INFO - [mozharness: 2016-11-18 17:03:18.099807Z] Running download-and-extract step. 09:03:18 INFO - Running pre-action listener: _resource_record_pre_action 09:03:18 INFO - Running main action method: download_and_extract 09:03:18 INFO - mkdir: /builds/slave/test/build/tests 09:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:18 INFO - trying https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:03:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:03:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:03:18 INFO - Downloaded 1361 bytes. 09:03:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:03:18 INFO - Using the following test package requirements: 09:03:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:03:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:03:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'jsshell-linux-x86_64.zip'], 09:03:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:03:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:03:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:03:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:03:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:03:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:03:19 INFO - Http code: 200 09:03:19 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:03:19 INFO - x-amz-cf-id: mu7fH9oZkJWHIwp6Hhk96HYN52qf0-k4Mhu32mO487jn0jLMOm0A9Q== 09:03:19 INFO - x-amz-version-id: _huz7wVDDCsFlQxQgSeWYBaLh70BJVIV 09:03:19 INFO - Expected file size: 20309666 09:03:19 INFO - Obtained file size: 20309666 09:03:23 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:03:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:03:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:03:24 INFO - Http code: 200 09:03:24 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:03:24 INFO - x-amz-cf-id: IiwmOkEUy0LzqOAVmsAK5UR4bZXypi7hHLwhT2mdssM9wEksAz0E4A== 09:03:24 INFO - x-amz-version-id: _huz7wVDDCsFlQxQgSeWYBaLh70BJVIV 09:03:24 INFO - Expected file size: 20309666 09:03:24 INFO - Obtained file size: 20309666 09:03:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:03:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:03:29 INFO - Http code: 200 09:03:29 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 09:03:29 INFO - x-amz-cf-id: eZRkqGmOVqKJ3_yQoaGvouFQhxuoxfI3m8oEYxIEYNwC8ARjKQNwjQ== 09:03:29 INFO - x-amz-version-id: xaunWu4I7LhNyfLunlUyEvcjLzRzycrq 09:03:29 INFO - Expected file size: 14409392 09:03:29 INFO - Obtained file size: 14409392 09:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:29 INFO - trying https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:03:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:03:30 INFO - Downloaded 55697405 bytes. 09:03:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:03:30 INFO - mkdir: /builds/slave/test/properties 09:03:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:30 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:30 INFO - Contents: 09:03:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:03:31 INFO - Running post-action listener: _resource_record_post_action 09:03:31 INFO - Running post-action listener: set_extra_try_arguments 09:03:31 INFO - [mozharness: 2016-11-18 17:03:31.545390Z] Finished download-and-extract step (success) 09:03:31 INFO - [mozharness: 2016-11-18 17:03:31.545617Z] Running populate-webroot step. 09:03:31 INFO - Running pre-action listener: _resource_record_pre_action 09:03:31 INFO - Running main action method: populate_webroot 09:03:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:31 INFO - '--tppagecycles', 09:03:31 INFO - '7'], 09:03:31 INFO - 'tests': ['tsvgm']}}, 09:03:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['damp', 'tps']}, 09:03:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'tests': ['damp', 'tps']}, 09:03:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['dromaeo_dom']}, 09:03:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['basic_compositor_video']}, 09:03:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:03:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['a11yr', 09:03:31 INFO - 'ts_paint', 09:03:31 INFO - 'tpaint', 09:03:31 INFO - 'sessionrestore', 09:03:31 INFO - 'sessionrestore_no_auto_restore', 09:03:31 INFO - 'tabpaint']}, 09:03:31 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:31 INFO - 'ts_paint', 09:03:31 INFO - 'tpaint', 09:03:31 INFO - 'sessionrestore', 09:03:31 INFO - 'sessionrestore_no_auto_restore', 09:03:31 INFO - 'tabpaint']}, 09:03:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:31 INFO - 'ts_paint', 09:03:31 INFO - 'tpaint', 09:03:31 INFO - 'sessionrestore', 09:03:31 INFO - 'sessionrestore_no_auto_restore', 09:03:31 INFO - 'tabpaint']}, 09:03:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:31 INFO - 'ts_paint', 09:03:31 INFO - 'tpaint', 09:03:31 INFO - 'sessionrestore', 09:03:31 INFO - 'sessionrestore_no_auto_restore', 09:03:31 INFO - 'tabpaint']}, 09:03:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['a11yr', 09:03:31 INFO - 'ts_paint', 09:03:31 INFO - 'tpaint', 09:03:31 INFO - 'sessionrestore', 09:03:31 INFO - 'sessionrestore_no_auto_restore', 09:03:31 INFO - 'tabpaint']}, 09:03:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['a11yr', 09:03:31 INFO - 'ts_paint', 09:03:31 INFO - 'tpaint', 09:03:31 INFO - 'sessionrestore', 09:03:31 INFO - 'sessionrestore_no_auto_restore', 09:03:31 INFO - 'tabpaint']}, 09:03:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['tsvgx', 09:03:31 INFO - 'tsvgr_opacity', 09:03:31 INFO - 'tart', 09:03:31 INFO - 'tscrollx', 09:03:31 INFO - 'cart']}, 09:03:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:31 INFO - 'tsvgr_opacity', 09:03:31 INFO - 'tart', 09:03:31 INFO - 'tscrollx', 09:03:31 INFO - 'cart']}, 09:03:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'talos_options': ['--disable-e10s'], 09:03:31 INFO - 'tests': ['tp5o']}, 09:03:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:03:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'talos_options': ['--disable-e10s', 09:03:31 INFO - '--xperf_path', 09:03:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:31 INFO - 'tests': ['tp5n']}, 09:03:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:03:31 INFO - 'talos_options': ['--xperf_path', 09:03:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:31 INFO - 'tests': ['tp5n']}}, 09:03:31 INFO - 'talos.zip': {'path': '', 09:03:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:31 INFO - Running post-action listener: _resource_record_post_action 09:03:31 INFO - [mozharness: 2016-11-18 17:03:31.567107Z] Finished populate-webroot step (success) 09:03:31 INFO - [mozharness: 2016-11-18 17:03:31.567195Z] Running create-virtualenv step. 09:03:31 INFO - Running pre-action listener: _resource_record_pre_action 09:03:31 INFO - Running main action method: create_virtualenv 09:03:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:31 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 09:03:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:31 INFO - Using real prefix '/usr' 09:03:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:34 INFO - Installing pip.................done. 09:03:34 INFO - Return code: 0 09:03:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:34 INFO - Reading from file tmpfile_stdout 09:03:34 INFO - Output received: 09:03:34 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) 09:03:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:34 INFO - Using env: {'DISPLAY': ':0', 09:03:34 INFO - 'HOME': '/home/cltbld', 09:03:34 INFO - 'LANG': 'en_US.UTF-8', 09:03:34 INFO - 'LANGUAGE': 'en_US:en', 09:03:34 INFO - 'LOGNAME': 'cltbld', 09:03:34 INFO - 'MAIL': '/var/mail/cltbld', 09:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:34 INFO - 'MOZ_NO_REMOTE': '1', 09:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:34 INFO - 'NO_EM_RESTART': '1', 09:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:34 INFO - 'PWD': '/builds/slave/test', 09:03:34 INFO - 'SHELL': '/bin/bash', 09:03:34 INFO - 'SHLVL': '1', 09:03:34 INFO - 'TERM': 'linux', 09:03:34 INFO - 'TMOUT': '86400', 09:03:34 INFO - 'USER': 'cltbld', 09:03:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:34 INFO - '_': '/tools/buildbot/bin/python'} 09:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:34 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 09:03:34 INFO - Cleaning up... 09:03:34 INFO - Return code: 0 09:03:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:34 INFO - Using env: {'DISPLAY': ':0', 09:03:34 INFO - 'HOME': '/home/cltbld', 09:03:34 INFO - 'LANG': 'en_US.UTF-8', 09:03:34 INFO - 'LANGUAGE': 'en_US:en', 09:03:34 INFO - 'LOGNAME': 'cltbld', 09:03:34 INFO - 'MAIL': '/var/mail/cltbld', 09:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:34 INFO - 'MOZ_NO_REMOTE': '1', 09:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:34 INFO - 'NO_EM_RESTART': '1', 09:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:34 INFO - 'PWD': '/builds/slave/test', 09:03:34 INFO - 'SHELL': '/bin/bash', 09:03:34 INFO - 'SHLVL': '1', 09:03:34 INFO - 'TERM': 'linux', 09:03:34 INFO - 'TMOUT': '86400', 09:03:34 INFO - 'USER': 'cltbld', 09:03:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:34 INFO - '_': '/tools/buildbot/bin/python'} 09:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:34 INFO - Downloading/unpacking psutil>=3.1.1 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:36 INFO - Installing collected packages: psutil 09:03:36 INFO - Running setup.py install for psutil 09:03:36 INFO - building 'psutil._psutil_linux' extension 09:03:36 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 09:03:37 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 09:03:37 INFO - building 'psutil._psutil_posix' extension 09:03:37 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 09:03:37 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 09:03:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:37 INFO - Successfully installed psutil 09:03:37 INFO - Cleaning up... 09:03:37 INFO - Return code: 0 09:03:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:03:37 INFO - Using env: {'DISPLAY': ':0', 09:03:37 INFO - 'HOME': '/home/cltbld', 09:03:37 INFO - 'LANG': 'en_US.UTF-8', 09:03:37 INFO - 'LANGUAGE': 'en_US:en', 09:03:37 INFO - 'LOGNAME': 'cltbld', 09:03:37 INFO - 'MAIL': '/var/mail/cltbld', 09:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:37 INFO - 'MOZ_NO_REMOTE': '1', 09:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:37 INFO - 'NO_EM_RESTART': '1', 09:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:37 INFO - 'PWD': '/builds/slave/test', 09:03:37 INFO - 'SHELL': '/bin/bash', 09:03:37 INFO - 'SHLVL': '1', 09:03:37 INFO - 'TERM': 'linux', 09:03:37 INFO - 'TMOUT': '86400', 09:03:37 INFO - 'USER': 'cltbld', 09:03:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:37 INFO - '_': '/tools/buildbot/bin/python'} 09:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:39 INFO - Installing collected packages: mozsystemmonitor 09:03:39 INFO - Running setup.py install for mozsystemmonitor 09:03:39 INFO - Successfully installed mozsystemmonitor 09:03:39 INFO - Cleaning up... 09:03:39 INFO - Return code: 0 09:03:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:03:39 INFO - Using env: {'DISPLAY': ':0', 09:03:39 INFO - 'HOME': '/home/cltbld', 09:03:39 INFO - 'LANG': 'en_US.UTF-8', 09:03:39 INFO - 'LANGUAGE': 'en_US:en', 09:03:39 INFO - 'LOGNAME': 'cltbld', 09:03:39 INFO - 'MAIL': '/var/mail/cltbld', 09:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:39 INFO - 'MOZ_NO_REMOTE': '1', 09:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:39 INFO - 'NO_EM_RESTART': '1', 09:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:39 INFO - 'PWD': '/builds/slave/test', 09:03:39 INFO - 'SHELL': '/bin/bash', 09:03:39 INFO - 'SHLVL': '1', 09:03:39 INFO - 'TERM': 'linux', 09:03:39 INFO - 'TMOUT': '86400', 09:03:39 INFO - 'USER': 'cltbld', 09:03:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:39 INFO - '_': '/tools/buildbot/bin/python'} 09:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:39 INFO - Downloading/unpacking jsonschema==2.5.1 09:03: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 09:03: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 09:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03: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 09:03: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 09:03:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03: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 09:03: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 09:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03: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 09:03: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 09:03:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:42 INFO - warning: no files found matching '*.txt' 09:03:42 INFO - no previously-included directories found matching 'build' 09:03:42 INFO - no previously-included directories found matching 'dist' 09:03:42 INFO - no previously-included directories found matching '.git*' 09:03:42 INFO - Installing collected packages: jsonschema, functools32 09:03:42 INFO - Running setup.py install for functools32 09:03:42 INFO - warning: no files found matching '*.txt' 09:03:42 INFO - no previously-included directories found matching 'build' 09:03:42 INFO - no previously-included directories found matching 'dist' 09:03:42 INFO - no previously-included directories found matching '.git*' 09:03:42 INFO - Successfully installed jsonschema functools32 09:03:42 INFO - Cleaning up... 09:03:42 INFO - Return code: 0 09:03:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:03:42 INFO - Using env: {'DISPLAY': ':0', 09:03:42 INFO - 'HOME': '/home/cltbld', 09:03:42 INFO - 'LANG': 'en_US.UTF-8', 09:03:42 INFO - 'LANGUAGE': 'en_US:en', 09:03:42 INFO - 'LOGNAME': 'cltbld', 09:03:42 INFO - 'MAIL': '/var/mail/cltbld', 09:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:42 INFO - 'MOZ_NO_REMOTE': '1', 09:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:42 INFO - 'NO_EM_RESTART': '1', 09:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:42 INFO - 'PWD': '/builds/slave/test', 09:03:42 INFO - 'SHELL': '/bin/bash', 09:03:42 INFO - 'SHLVL': '1', 09:03:42 INFO - 'TERM': 'linux', 09:03:42 INFO - 'TMOUT': '86400', 09:03:42 INFO - 'USER': 'cltbld', 09:03:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:42 INFO - '_': '/tools/buildbot/bin/python'} 09:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:42 INFO - Cleaning up... 09:03:42 INFO - Return code: 0 09:03:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:03:42 INFO - Using env: {'DISPLAY': ':0', 09:03:42 INFO - 'HOME': '/home/cltbld', 09:03:42 INFO - 'LANG': 'en_US.UTF-8', 09:03:42 INFO - 'LANGUAGE': 'en_US:en', 09:03:42 INFO - 'LOGNAME': 'cltbld', 09:03:42 INFO - 'MAIL': '/var/mail/cltbld', 09:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:42 INFO - 'MOZ_NO_REMOTE': '1', 09:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:42 INFO - 'NO_EM_RESTART': '1', 09:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:42 INFO - 'PWD': '/builds/slave/test', 09:03:42 INFO - 'SHELL': '/bin/bash', 09:03:42 INFO - 'SHLVL': '1', 09:03:42 INFO - 'TERM': 'linux', 09:03:42 INFO - 'TMOUT': '86400', 09:03:42 INFO - 'USER': 'cltbld', 09:03:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:42 INFO - '_': '/tools/buildbot/bin/python'} 09:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:42 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 09:03:42 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 09:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:42 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 09:03:42 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 09:03:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03: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 09:03: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 09:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03: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 09:03: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 09:03:45 INFO - Downloading docopt-0.6.1.tar.gz 09:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:45 INFO - Running setup.py install for blobuploader 09:03:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:45 INFO - Running setup.py install for requests 09:03:46 INFO - Running setup.py install for docopt 09:03:46 INFO - Successfully installed blobuploader requests docopt 09:03:46 INFO - Cleaning up... 09:03:46 INFO - Return code: 0 09:03:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:03:46 INFO - Using env: {'DISPLAY': ':0', 09:03:46 INFO - 'HOME': '/home/cltbld', 09:03:46 INFO - 'LANG': 'en_US.UTF-8', 09:03:46 INFO - 'LANGUAGE': 'en_US:en', 09:03:46 INFO - 'LOGNAME': 'cltbld', 09:03:46 INFO - 'MAIL': '/var/mail/cltbld', 09:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:46 INFO - 'MOZ_NO_REMOTE': '1', 09:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:46 INFO - 'NO_EM_RESTART': '1', 09:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:46 INFO - 'PWD': '/builds/slave/test', 09:03:46 INFO - 'SHELL': '/bin/bash', 09:03:46 INFO - 'SHLVL': '1', 09:03:46 INFO - 'TERM': 'linux', 09:03:46 INFO - 'TMOUT': '86400', 09:03:46 INFO - 'USER': 'cltbld', 09:03:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:46 INFO - '_': '/tools/buildbot/bin/python'} 09:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:46 INFO - Running setup.py (path:/tmp/pip-Kb8Pi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:46 INFO - Running setup.py (path:/tmp/pip-MUpByr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:46 INFO - Running setup.py (path:/tmp/pip-R17h75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:46 INFO - Running setup.py (path:/tmp/pip-rHgPEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:46 INFO - Running setup.py (path:/tmp/pip-pbaPt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:46 INFO - Running setup.py (path:/tmp/pip-4xDdg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:46 INFO - Running setup.py (path:/tmp/pip-VEWvZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:46 INFO - Running setup.py (path:/tmp/pip-IESag0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:46 INFO - Running setup.py (path:/tmp/pip-WZlWLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:47 INFO - Running setup.py (path:/tmp/pip-mwJFI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:47 INFO - Running setup.py (path:/tmp/pip-Vgpcs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:47 INFO - Running setup.py (path:/tmp/pip-N_cnSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:47 INFO - Running setup.py (path:/tmp/pip-L9p1xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:47 INFO - Running setup.py (path:/tmp/pip-TdHm5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:47 INFO - Running setup.py (path:/tmp/pip-YllrRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:47 INFO - Running setup.py (path:/tmp/pip-JhnQoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:47 INFO - Running setup.py (path:/tmp/pip-3S2vKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:47 INFO - Running setup.py install for manifestparser 09:03:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:47 INFO - Running setup.py install for mozcrash 09:03:47 INFO - Running setup.py install for mozdebug 09:03:47 INFO - Running setup.py install for mozdevice 09:03:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Running setup.py install for mozfile 09:03:48 INFO - Running setup.py install for mozhttpd 09:03:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Running setup.py install for mozinfo 09:03:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Running setup.py install for mozInstall 09:03:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Running setup.py install for mozleak 09:03:48 INFO - Running setup.py install for mozlog 09:03:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Running setup.py install for moznetwork 09:03:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:48 INFO - Running setup.py install for mozprocess 09:03:48 INFO - Running setup.py install for mozprofile 09:03:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:49 INFO - Running setup.py install for mozrunner 09:03:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:49 INFO - Running setup.py install for mozscreenshot 09:03:49 INFO - Running setup.py install for moztest 09:03:49 INFO - Running setup.py install for mozversion 09:03:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:49 INFO - Cleaning up... 09:03:49 INFO - Return code: 0 09:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:03:49 INFO - Using env: {'DISPLAY': ':0', 09:03:49 INFO - 'HOME': '/home/cltbld', 09:03:49 INFO - 'LANG': 'en_US.UTF-8', 09:03:49 INFO - 'LANGUAGE': 'en_US:en', 09:03:49 INFO - 'LOGNAME': 'cltbld', 09:03:49 INFO - 'MAIL': '/var/mail/cltbld', 09:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:49 INFO - 'MOZ_NO_REMOTE': '1', 09:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:49 INFO - 'NO_EM_RESTART': '1', 09:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:49 INFO - 'PWD': '/builds/slave/test', 09:03:49 INFO - 'SHELL': '/bin/bash', 09:03:49 INFO - 'SHLVL': '1', 09:03:49 INFO - 'TERM': 'linux', 09:03:49 INFO - 'TMOUT': '86400', 09:03:49 INFO - 'USER': 'cltbld', 09:03:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:49 INFO - '_': '/tools/buildbot/bin/python'} 09:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:49 INFO - Running setup.py (path:/tmp/pip-AhvnL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:49 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)) 09:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:49 INFO - Running setup.py (path:/tmp/pip-13IWFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:49 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)) 09:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:49 INFO - Running setup.py (path:/tmp/pip-_Vm_sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:49 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)) 09:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:49 INFO - Running setup.py (path:/tmp/pip-g6GBTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 09:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:49 INFO - Running setup.py (path:/tmp/pip-GNRek2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:50 INFO - Running setup.py (path:/tmp/pip-g78oUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:50 INFO - Running setup.py (path:/tmp/pip-6C_1UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:50 INFO - Running setup.py (path:/tmp/pip-2ukyks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:50 INFO - Running setup.py (path:/tmp/pip-Wa6pcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:50 INFO - Running setup.py (path:/tmp/pip-zUbYVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:50 INFO - Running setup.py (path:/tmp/pip-WIW0f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:50 INFO - Running setup.py (path:/tmp/pip-QoqMuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:50 INFO - Running setup.py (path:/tmp/pip-FI8dwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:50 INFO - Running setup.py (path:/tmp/pip-QlrtKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:50 INFO - Running setup.py (path:/tmp/pip-u2i5SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:50 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:50 INFO - Running setup.py (path:/tmp/pip-VX8um2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:50 INFO - Running setup.py (path:/tmp/pip-NCSXmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:50 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:52 INFO - Downloading blessings-1.6.tar.gz 09:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:52 INFO - Installing collected packages: blessings 09:03:52 INFO - Running setup.py install for blessings 09:03:53 INFO - Successfully installed blessings 09:03:53 INFO - Cleaning up... 09:03:53 INFO - Return code: 0 09:03:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:53 INFO - Reading from file tmpfile_stdout 09:03:53 INFO - Current package versions: 09:03:53 INFO - argparse == 1.2.1 09:03:53 INFO - blessings == 1.6 09:03:53 INFO - blobuploader == 1.2.4 09:03:53 INFO - docopt == 0.6.1 09:03:53 INFO - functools32 == 3.2.3-2 09:03:53 INFO - jsonschema == 2.5.1 09:03:53 INFO - manifestparser == 1.1 09:03:53 INFO - mozInstall == 1.12 09:03:53 INFO - mozcrash == 1.0 09:03:53 INFO - mozdebug == 0.1 09:03:53 INFO - mozdevice == 0.48 09:03:53 INFO - mozfile == 1.2 09:03:53 INFO - mozhttpd == 0.7 09:03:53 INFO - mozinfo == 0.9 09:03:53 INFO - mozleak == 0.1 09:03:53 INFO - mozlog == 3.4 09:03:53 INFO - moznetwork == 0.27 09:03:53 INFO - mozprocess == 0.23 09:03:53 INFO - mozprofile == 0.28 09:03:53 INFO - mozrunner == 6.13 09:03:53 INFO - mozscreenshot == 0.1 09:03:53 INFO - mozsystemmonitor == 0.3 09:03:53 INFO - moztest == 0.7 09:03:53 INFO - mozversion == 1.4 09:03:53 INFO - psutil == 3.1.1 09:03:53 INFO - requests == 1.2.3 09:03:53 INFO - wsgiref == 0.1.2 09:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:03:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:03:53 INFO - Using env: {'DISPLAY': ':0', 09:03:53 INFO - 'HOME': '/home/cltbld', 09:03:53 INFO - 'LANG': 'en_US.UTF-8', 09:03:53 INFO - 'LANGUAGE': 'en_US:en', 09:03:53 INFO - 'LOGNAME': 'cltbld', 09:03:53 INFO - 'MAIL': '/var/mail/cltbld', 09:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:53 INFO - 'MOZ_NO_REMOTE': '1', 09:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:53 INFO - 'NO_EM_RESTART': '1', 09:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:53 INFO - 'PWD': '/builds/slave/test', 09:03:53 INFO - 'SHELL': '/bin/bash', 09:03:53 INFO - 'SHLVL': '1', 09:03:53 INFO - 'TERM': 'linux', 09:03:53 INFO - 'TMOUT': '86400', 09:03:53 INFO - 'USER': 'cltbld', 09:03:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:53 INFO - '_': '/tools/buildbot/bin/python'} 09:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 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)) 09:03:53 INFO - Cleaning up... 09:03:53 INFO - Return code: 0 09:03:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa7075a5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', '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 09:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:03:53 INFO - Using env: {'DISPLAY': ':0', 09:03:53 INFO - 'HOME': '/home/cltbld', 09:03:53 INFO - 'LANG': 'en_US.UTF-8', 09:03:53 INFO - 'LANGUAGE': 'en_US:en', 09:03:53 INFO - 'LOGNAME': 'cltbld', 09:03:53 INFO - 'MAIL': '/var/mail/cltbld', 09:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:53 INFO - 'MOZ_NO_REMOTE': '1', 09:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:53 INFO - 'NO_EM_RESTART': '1', 09:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:53 INFO - 'PWD': '/builds/slave/test', 09:03:53 INFO - 'SHELL': '/bin/bash', 09:03:53 INFO - 'SHLVL': '1', 09:03:53 INFO - 'TERM': 'linux', 09:03:53 INFO - 'TMOUT': '86400', 09:03:53 INFO - 'USER': 'cltbld', 09:03:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:53 INFO - '_': '/tools/buildbot/bin/python'} 09:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:53 INFO - Cleaning up... 09:03:53 INFO - Return code: 0 09:03:53 INFO - Running post-action listener: _resource_record_post_action 09:03:53 INFO - Running post-action listener: _start_resource_monitoring 09:03:53 INFO - Starting resource monitoring. 09:03:53 INFO - [mozharness: 2016-11-18 17:03:53.835794Z] Finished create-virtualenv step (success) 09:03:53 INFO - [mozharness: 2016-11-18 17:03:53.836318Z] Running install step. 09:03:53 INFO - Running pre-action listener: _resource_record_pre_action 09:03:53 INFO - Running main action method: install 09:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:54 INFO - Reading from file tmpfile_stdout 09:03:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:54 INFO - Reading from file tmpfile_stdout 09:03:54 INFO - Output received: 09:03:54 INFO - Usage: mozinstall [options] installer 09:03:54 INFO - Options: 09:03:54 INFO - -h, --help show this help message and exit 09:03:54 INFO - -d DEST, --destination=DEST 09:03:54 INFO - Directory to install application into. [default: 09:03:54 INFO - "/builds/slave/test"] 09:03:54 INFO - --app=APP Application being installed. [default: firefox] 09:03:54 INFO - mkdir: /builds/slave/test/build/application 09:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:04:10 INFO - Reading from file tmpfile_stdout 09:04:10 INFO - Output received: 09:04:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:10 INFO - Running post-action listener: _resource_record_post_action 09:04:10 INFO - [mozharness: 2016-11-18 17:04:10.305458Z] Finished install step (success) 09:04:10 INFO - [mozharness: 2016-11-18 17:04:10.305701Z] Running run-tests step. 09:04:10 INFO - Running pre-action listener: _resource_record_pre_action 09:04:10 INFO - Running main action method: run_tests 09:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:10 INFO - Python 2.7.3 09:04:10 INFO - Return code: 0 09:04:10 INFO - grabbing minidump binary from tooltool 09:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:04:10 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 0x1700fc0>, '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 0x1701ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:10 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 09:04:10 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 09:04:10 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 09:04:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:10 INFO - Return code: 0 09:04:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:10 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/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:04:10 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/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:04:10 INFO - Using env: {'DISPLAY': ':0', 09:04:10 INFO - 'HOME': '/home/cltbld', 09:04:10 INFO - 'LANG': 'en_US.UTF-8', 09:04:10 INFO - 'LANGUAGE': 'en_US:en', 09:04:10 INFO - 'LOGNAME': 'cltbld', 09:04:10 INFO - 'MAIL': '/var/mail/cltbld', 09:04:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:10 INFO - 'MOZ_NO_REMOTE': '1', 09:04:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:10 INFO - 'NO_EM_RESTART': '1', 09:04:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:10 INFO - 'PWD': '/builds/slave/test', 09:04:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:10 INFO - 'SHELL': '/bin/bash', 09:04:10 INFO - 'SHLVL': '1', 09:04:10 INFO - 'TERM': 'linux', 09:04:10 INFO - 'TMOUT': '86400', 09:04:10 INFO - 'USER': 'cltbld', 09:04:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622', 09:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:10 INFO - '_': '/tools/buildbot/bin/python'} 09:04:10 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/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:04:10 INFO - mozversion application_buildid: 20161118074928 09:04:10 INFO - mozversion application_changeset: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 09:04:10 INFO - mozversion application_display_name: Nightly 09:04:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:10 INFO - mozversion application_name: Firefox 09:04:10 INFO - mozversion application_remotingname: firefox 09:04:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:04:10 INFO - mozversion application_vendor: Mozilla 09:04:10 INFO - mozversion application_version: 53.0a1 09:04:10 INFO - mozversion platform_buildid: 20161118074928 09:04:10 INFO - mozversion platform_changeset: 6186126f502ba47e4fb2b6f4d971ea6fd3e66a02 09:04:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:04:10 INFO - mozversion platform_version: 53.0a1 09:04:10 INFO - using testdate: 1479488650 09:04:10 INFO - actual date: 1479488650 09:04:10 INFO - starting webserver on 'localhost:49814' 09:04:10 INFO - SUITE-START | Running 2 tests 09:04:10 INFO - TEST-START | dromaeo_css 09:04:10 INFO - operating with platform_type : linux_ 09:04:10 INFO - Initialising browser for dromaeo_css test... 09:04:10 INFO - TEST-INFO | started process 6812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGSTZfg/profile http://localhost:49814/getInfo.html) 09:04:15 INFO - PROCESS | 6812 | __metrics Screen width/height:1600/1200 09:04:15 INFO - PROCESS | 6812 | colorDepth:24 09:04:15 INFO - PROCESS | 6812 | Browser inner width/height: 1024/697 09:04:15 INFO - PROCESS | 6812 | __metrics 09:04:15 ERROR - PROCESS | 6812 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 09:04:16 INFO - TEST-INFO | 6812: exit 0 09:04:16 INFO - Browser initialized. 09:04:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:16 INFO - TEST-INFO | started process 6934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGSTZfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:28 INFO - PROCESS | 6934 | RSS: Main: 188317696 09:04:28 INFO - PROCESS | 6934 | 09:05:18 INFO - PROCESS | 6934 | 1479488718680 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:07:33 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:49814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49814/tests/dromaeo/cssquery-ext.html) 09:07:34 INFO - PROCESS | 6934 | RSS: Main: 197300224 09:07:34 INFO - PROCESS | 6934 | 09:10:36 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:49814/tests/dromaeo/cssquery-ext.html (next: http://localhost:49814/tests/dromaeo/cssquery-jquery.html) 09:10:37 INFO - PROCESS | 6934 | RSS: Main: 197746688 09:10:37 INFO - PROCESS | 6934 | 09:13:39 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:49814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49814/tests/dromaeo/cssquery-mootools.html) 09:13:39 INFO - PROCESS | 6934 | RSS: Main: 200392704 09:13:39 INFO - PROCESS | 6934 | 09:16:42 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:49814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49814/tests/dromaeo/cssquery-prototype.html) 09:16:42 INFO - PROCESS | 6934 | RSS: Main: 196718592 09:16:42 INFO - PROCESS | 6934 | 09:19:45 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:49814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49814/tests/dromaeo/cssquery-yui.html) 09:19:46 INFO - PROCESS | 6934 | RSS: Main: 199577600 09:19:46 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | Cycle 1(1): loaded http://localhost:49814/tests/dromaeo/cssquery-yui.html (next: http://localhost:49814/tests/dromaeo/cssquery-dojo.html) 09:22:49 INFO - PROCESS | 6934 | RSS: Main: 200089600 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | __start_tp_report 09:22:49 INFO - PROCESS | 6934 | _x_x_mozilla_page_load 09:22:49 INFO - PROCESS | 6934 | _x_x_mozilla_page_load_details 09:22:49 INFO - PROCESS | 6934 | |i|pagename|runs| 09:22:49 INFO - PROCESS | 6934 | |0;dojo.html;2561.142017424163;2591.1060684064005;2591.650127232823;2611.1122218445726;2629.5792673172296;4451.376807246988;4556.749378784161;4597.448306203256;4616.169089563886;4647.651426143036;4509.098180363924;4627.305904114384;4658.79035443405;4694.201985662437;4694.4601370842365;4303.24693178694;4327.567243275679;4407.911841763163;4415.072834704716;4468.285074388098;4301.225779359714;4339.522652508222;4353.346997950317;4403.933940990888;4432.3794668746405;4187.246295666779;4214.536400995888;4260.893477663052;4300.397944287803;4326.113146804929;4271.572842715735;4279.700420970534;4304.117655880537;4331.956680433187;4356.43366362374;4246.214450326699;4279.40088387626;4300.419443375135;4321.308590625485;4332.0469496710675;4481.170983368054;4484.955150448486;4614.423197100363;4630.143423466636;4638.072385522909;4945.579625731817;4963.40439147301;5018.197088465864;5022.6233032522705;5080.618953578496;5035.672681275742;5049.949500504985;5051.646384753032;5058.873528161788;5099.235114732783;4548.1813273610405;4700.247960326331;4717.599004084623;4721.102990431807;4743.169945259566;4973.975130124399;5033.924491132636;5044.218146187347;5052.974735126374;5134.5635620972635;4847.297141914402;4852.636052296092;4852.781624826891;4867.571236084618;4901.558859702573;4839.370881785416;4958.082754690394;4964.925526117111;4965.90068198634;4969.0807200668;4842.951570484321;4865.635077369211;4906.31311616374;4907.7300748458465;4911.803527858917;4870.4155501339355;4892.804287828447;4915.631327650441;4920.286558449005;4956.4547899731;4223.282042052859;4240.766757828287;4241.936370954438;4245.1934132514725;4251.192273468031;3639.181184233579;3707.2029513654693;3707.4068149096556;3714.609965953536;3746.3818469952153;4139.985703502661;4156.688248381383;4171.958280417218;4201.390798334285;4247.320428731388;5023.246513023003;5025.346704928409;5034.8237811677145;5040.924386134211;5076.492350764968;4276.5295817460055;4298.699091063658;4302;4313.202057619351;4340.175366680321;4323.870283891425;4362.9781851091175;4419.64642828573;4461.063176732922;4511.390962220124;4648.047150334241;4663.906721865475;4671.579557839811;4683.391159149289;4715.6699031068865;4936.185529387611;4950.6782059166035;4951.306817045544;4952.653314267966;4978.178600530872;4502.3471596618965;4550.658700597534;4552.908941821212;4639.698419602715;4694.084653492536;4781.832635857728;4828.806847726192;4845.1520983828395;4851.151048566558;4889.828855990023;4921.188003979303;4934.827281045146;4936.358273424576;4936.9259461107395;4957.553820156203;4926.359573255454;4936.0868239374395;4938.481459446706;4942.258661200849;4963.057019166491;4723.527647235249;4732.73969931657;4756.762161891822;4774.737389443475;4943.802247910044;4720.45714742809;4729.219678752967;4741.217699079613;4746.5490778376;4750.049990001944;4677.087967846237;4765.142274390643;4781.856544303677;4832.975835120802;4833.2025215840395;4697.976510117564;4704;4715.528447155394;4745.38310019709;4788.832390866303 09:22:49 INFO - PROCESS | 6934 | |1;ext.html;515.6442054982062;536.895305415444;545.5090418623241;558.5419955636377;564.5737468211499;27860;30194.39611207777;30228.697713022862;38725.41911871317;39482.210355792864;38649.420258696075;39198.21603567927;39452;39490;39516.20967580654;7409.036825212728;7507.849843003164;7563.848723025536;7571.583562904038;7581.09026916768;7456.850862982737;7574.697012119509;7577.962110189469;7579.545227286353;7589.848203035936;7534.284242996907;7556.2443755624545;7569.129550101727;7572.583507907063;7574.886376704354;7507.512011719248;7535.3594944429515;7542.660580273846;7553.395728341774;7564.432667549956;7464.290892365217;7509.774706758806;7509.924900750977;7520.398368130536;7529.9247007529775;36062;36516.63483365186;36723.265534689155;36726.26547469036;36785.632143678486;2935.9412811743646;2982.9552556711665;3047.832369219692;3172.460681684119;3177.523371494294;27704.445911081868;28021.159365219075;28100.71899281022;28245.576316355273;28655.14034578966;3424.2466657335344;3514.912127196815;3531.699805516534;3610.492932853401;3664.157243833933;233188;234144;235538;235712;236667;49277.75361123243;49459;49498.50501495011;49629.25556116661;49657.50342496529;52944;53096.73451632717;53103.468965310625;53140.46859531433;53204.467955320724;13517.59447216585;13965.23191224472;14020.369083391271;14024.08843425174;14025;9499.43003419797;9621.663241786504;9624.903750962401;9641.710748677551;9668.661596844076;15204;15216.695666086616;15234.238288085551;15450.768238476432;15629.843701563066;5386.730663466811;5503.220873458958;5505.889882202334;5616.354119276254;5649.406812284733;767.5855038279378;910.8906931168169;920.9953950230206;964.4513751626379;988.6342053440274;26516.867415662797;27076.458470830472;27144.592831107548;27215.45569088647;27611.30971725723;774.9576819178196;903.8734577159203;917.7613820406742;938.4134915677702;982.9017098290113;13190.823514120062;14156.575302740934;14224.644383890278;14227.715445691028;14404.567862964128;326191;327649.53226636956;328573;328689;328874;46894.296585551245;46963;47005;47023.5297647026;47206.76396618064;1134.0927258193412;1163.2206421697483;1168.59099315239;1173.4250217393417;1174.5947648061406;24852.627210591494;25603.487930240917;25895.35261618399;26761.33096672599;26887.462250755267;39870.80064599775;40100.799496002335;40118.39822402608;40221.39667905042;40242.798786005886;295420;296945;297022;297681;299122;33794.831025844716;34810.82594587011;35534.28931421409;35595.288094237454;35636.46545301875;40637;40786.59213407947;40791.112390157454;41307.7934610325;41325.586744132175;34858.47712284267;35058.123546911535;35128.82435587806;35512.644873551966;36005.819970899975;34605.82697086498;34735.30529389449;34736;34807.82596087003;34994.650053500154;31179.688203118585;34232.82883585666;34541.13647158841;34959.40649496068;37463.81268093642;29521.557176641938;31768.841155794074;31843;32271.67728322687;32302.515462267616;24433;24854.254372368858;24901.377465563506;25034.3741406459;25292.74707252904 09:22:49 INFO - PROCESS | 6934 | |2;jquery.html;315.8073575119178;330.712280316125;330.95863017122855;337.42132243202934;346.4543344232834;15543.922280388611;15608;16991.83008169918;17020.31918723251;17112.743308850346;15315.617109572266;15411.614709632266;15913;15923;16052.759208611851;4784.378030855993;4837.250226214942;5018.372703412074;5042.974785126069;5068.1130802109665;4987.75061246938;5082.593392528589;5092.9236061459105;5101;5103.336566246383;4965.28003439501;5067.315912351841;5070.594352451795;5080.390353157626;5252.606054545905;5210.374755029402;5286.101362768339;5287.629865909388;5288.391834938992;5296.496832800878;5064.56951159152;5113.386393632751;5167.6641018333685;5284.788608455658;5316.9202461963105;11592.47833847479;11813.468393922294;11820.527178912833;11839.348835814028;15151.469698560497;1716.6395057038037;1873.653374125791;2012.8691635043676;2074.5332300232476;2167.6206663833764;8619.698310559163;8732.51971141587;8895.510746908918;8915.55422228886;9071.909280907239;1655.635760132781;1719.4173694009482;1747.0931386166008;1775.254393154865;1777.9377721779676;38015.42976855349;39362.21275574501;41500.79249603733;71545.64227178883;73604;9213.631454741735;9280.443173409618;9291.234665413549;9407.341486095907;9619.422834629944;12819.16675416095;12823.35883205836;12860.164089334163;12868.099233053783;12884.742305153844;6553.246376666744;6939.063226464464;7070.823229419203;7149.177844547839;7153.070100886852;6628.403443689995;6638.834029149213;6689.632070236086;6853.657317134123;6903.1716194057035;3882.9611703883165;3925.803709814498;3943.2704949584418;3988.262171498282;4125.1131006833675;1663.708850951103;1745.5810605454599;1760.313477743681;1762.5857923387994;1804.404546499652;755.2447552447552;766.8581312457213;887.7070566712969;907.4827348411342;910.8497097978892;15851.286692098884;15884.841151588567;16534.503964881074;16958.550206299868;17292.394766183123;807.6567458829974;821.4332110843499;821.5645707774889;835.8996920369473;840.1220724343076;8963.417377870417;9586.520673966274;9674.322797404115;9706.660266890625;9743.951280243695;377085;380122;384289;387641;387824;73951.63024184844;75207;76589.61705191438;76642.23357766462;76676;867.8568036273944;893.2005854759954;931.380631879806;934.3272843552631;938.6761567259284;15454.304556294768;15460.84539154639;15646.452374166849;15795.921020394824;16193.75709364337;37922;38284.42573361346;39481.605183948945;39532.40701389424;39583;53669.19496207482;53676.46323536715;53702.462975369745;54837.725811370685;54940.72529637326;6746.4265537429865;6845.691943862438;7080.929190708027;7164.677589508589;7465.328120469184;9921.305508614329;10592.788144236918;10821.891781082404;10865.18511111654;10905;9631.566579504079;9632.9036709632;9771.364861283993;9891.109800118023;9986.700398988041;9260.259179265777;9369.953150234205;9404.153626173676;9696.5151742414;9963.750906227402;9298.256139508689;9650.662226822027;9664.468454234804;9707.174890134134;9818;6977.298693557281;7091.858162836817;7154.2130365658695;7157.785266442015;7301;7842.9215707842195;9436.150746432853;9449.622015119317;9610.855837162588;9896.653617123366 09:22:49 INFO - PROCESS | 6934 | |3;mootools.html;1329.5612447892192;1353.9458421663135;1421.694335717821;1606.3815431059038;1645.4652238022645;6293.24481062272;6501.057346684728;6713.966430167849;7189.568625882444;7196.208417074117;6812.523123381353;7061.435085193185;7076.823079423017;7078.646067696607;7219.278072192791;2051.907664155113;2102.8633138846003;2107.4415279950827;2117.87292762434;2119.1841141160685;2083.479130217446;2106.0838535237144;2168.902399392031;2171.8262538996923;2172.424307558498;2072.8134467897885;2112.049577690038;2116.3121985354746;2146.5170336674278;2147.31285988483;2003.869748466345;2029.2086086426232;2029.736134302546;2031.2788959919164;2032;2060.8866512341815;2066.318115022039;2079.8440116991137;2094.099537199004;2096.5282811367474;7108.537945033608;7128.9287107128785;7168.175659799138;7198.388137008361;7212.423006159547;4194.874153775361;4310.28880234764;4316.179925814085;4327;4333.674974376934;2799.3281612412875;2808.8314701117793;2852.7147285271512;2855.9428811423863;2868.827870327787;846.3483117999168;878.284198378326;900.8513595256775;912.8676341930383;938.3197182043033;9212.170904618617;9386.718398448058;9410.153086222273;9456.621735130586;9466;3675.834587443518;3863.9227215455535;3927.1752931884052;3927.2341893330527;3933.724639275223;8214.301784348398;8240.8351832963;8247.21651443112;8285.50286982783;8293.21214484623;4316.762578058237;4323.178596066738;4359.498657654347;4361.6074553290355;4377.715448495837;3437.9656203438144;3553.466979952976;3857.787821669835;3866.516685414323;3948.3287841067086;3335.6664333566932;3344.88292909747;3412.4369479036177;3456.3087382523595;3473.7394695397948;1091.4270008245735;1102.6306187427301;1112.4215407987963;1130.4517309105076;1149.5918948773065;629.4492319220682;709.8367375503663;791.782259878538;795.3120550723582;829.2453866981018;4856.635752318591;4897.4857639948;4932.728699921467;5124.871878203;5304.549113325334;771.5833449937084;771.9498232614862;796.366888323784;801;827.5489858027389;3313.022658315803;3318.6515415881468;3369.039823650297;3400.1329660936303;3410.334984677964;8293.751187464386;8780.648774048967;8786.516741579147;8787.340949428819;8794;8703.216710496086;8719.956400217958;8726.607302671267;8731.738047858575;8746.338195742916;6517.804465866032;6794.116764820542;6798.660066996729;6803.9319606805275;6825.078614386995;4949.178114825685;4964.702117872939;4981.900361992667;5113.51421614946;5279.340082489689;7741.458097933316;7914.44598878073;7985.880211796712;8065.596720164086;8103.473274237156;8115.715949941724;8118.83762324762;8161.347092232489;8206;8214.34285257166;5644.520215781705;5833.154192642128;6088.482478989158;6232.096346029891;6243.282022567463;6624.006399040182;6935.098437203132;6937.236903940663;6937.618430986142;7085.57486550788;6281.96859015702;6429.067785171217;6513.609183449008;6632.4694024478895;6735.730570777114;6452.516061295328;6524.543281970216;6559.508036897157;6580.868382632416;6653.301403352578;5717.628354156966;5775.249217601685;5822.94177058224;5829.38791426911;5903.350631430453;4314.741115533078;4412.9117417652105;4506.008678090815;4561.270196768501;4619.376384188092;4576.313552967082;4579.9542004579525;4657.300085468847;4676.321933319718;4841.394825646794 09:22:49 INFO - PROCESS | 6934 | |4;prototype.html;280.29645589570174;280.93819359740854;288.8642338101092;289.1470163019093;291.3531959050909;4774.212254977924;4831.9275210871865;4950.158473059584;4976.253561965707;4997.475265097167;4728.267118596623;4771.1888978873585;4866.562009419152;4890.779914903829;4892.926606100911;3790.4882840816413;3808.447775072627;3819.618038196186;3824.445455408978;3862.806859657013;3709.610490898457;3824.388097904336;3829.195868867527;3834.559025712037;3839.34731095713;3794.203217324365;3801.1257410795533;3805.2389522095555;3813.523309586302;3814.9046273843237;3813;3814.7520411173464;3816.618338166175;3818.4463252828186;3850.8652197172964;3154.794938329001;3265.2326703224962;3349.5478110455265;3365.848536815849;3396.607390969715;4735.289706544046;4745;4752.006236071253;4756.31033500144;4767.737774422405;4252.914941701149;4284.571542845691;4284.592963668447;4285.849995250152;4291.4850217973735;4935.852903986777;5083.669561478492;5098.4646612105935;5101.51535604117;5101.744912754348;3550.751447398683;3579.0515513388973;3581.3732596795717;3584.6415358464205;3594.101474631342;5359.276497672803;5371.274877891474;5382.703951282678;5384.703841288728;5387.410713839387;3633.7819730816236;3640.2537479816574;3657.6890964267805;3663.3589121904092;3663.5454245655474;3474.270403215353;3664.6152154023443;3688.4836122942274;3712.7401081924545;3717.516722826015;4237.63980061692;4247.235497610398;4259.3185090386005;4259.446271984622;4266.530681625019;5112.667676601009;5126.38483381989;5129.512696293846;5195.454477279907;5201.401838788512;1175.8118701007797;1176.4176732517287;1208.8186771984097;1250.4310538704867;1259.817326487654;828.2173346187794;847.3179090831816;847.737201467547;849.3332733803934;855.1448551448551;4264.829406823755;4274.380214868826;4281.678874084456;4337.175936572041;4353.564643535685;5088.92120267233;5095.592352611782;5102.336696229467;5115.514026167582;5143.691378517301;4200.768957707355;4309.439772829513;4311.736338422291;4331.436913201263;4358.476982762026;2664;2669.7730692891323;2676.665416822897;2678.691950425687;2686.838789672626;4708.199606066977;4715.929261061086;4728.3380326753595;4734.289856521549;4753.215719406328;4831.73425461603;5047.2429135629945;5125.384953805493;5136.409312928986;5167.870803229875;4728.810847566127;4732.148213321635;4738.763061846894;4741.596964258077;4741.739204343794;5024.346834911438;5044.167712327571;5062.645614806928;5065.341505604248;5065.4428012917815;4989.675671081368;5207.3490813648295;5214.713190774544;5223.921641175461;5231.398389185292;5001.42483614389;5015.097282489041;5025.572826309804;5026.698398095979;5036.269740887624;3651.8539258429364;3667.8349474273186;3687.2256826066828;3694.482772411918;3695.963040369562;5188.403333616682;5238.371395432572;5251.606129540223;5270.578353731616;5356.57147428197;5101.821436249714;5133.537981581676;5141.948580514147;5143.8456846294675;5159.819406320761;5080.644354895122;5176.757578181134;5187.948120518747;5203.687778733288;5232.7645255964335;4795.928061079157;4940.160172770709;5040.218766091261;5062.974685126551;5068.109274550077;5003.174476211384;5116.872078198075;5155.43290238066;5161.5805653445605;5171.612129090258;5055.898882022412;5056.241563765465;5058.064258112261;5059.19052951526;5080.441151473261 09:22:49 INFO - PROCESS | 6934 | |5;yui.html;624.8516965909989;648.5881465269553;684.1379861374667;726.6657337624692;748.9625518724064;12122.69693257669;12911.870881291185;12964.870351296484;13000.28498432587;13072.21566705997;12108.757824843498;12276.508939642426;12289.508419663225;12289.877101228985;12368.443420046096;753.4236309223421;761.4707778094213;775.3138472451865;790.7034861926777;797.131127071492;786.382689588673;787.79123532264;788.0464637788255;788.3299195683652;788.7081779741475;835.6740871060291;836.2849763452252;837.0917554453395;837.5100566168768;839.2614499240659;820.6143112737034;824.9216324449168;825.5624519004876;827.5696637748338;833.3666413525734;601.6390165900468;601.6660753281927;602.325395556979;602.4607975861624;604.7157835817203;12839.422225999853;12846.935765321206;12918.418671159727;12944.935275323563;12996.545120920817;11678.591249306319;11922.880771192264;11981.820272695917;11997;12251.203671761306;8059.677612895477;8103.392245581605;10106.696799096038;10221.64224252155;10497.527611257512;3122.370013296222;3158.2262345725217;3176.142441540794;3188.1232661018175;3221.6617255188103;48487.75756121197;48632.513674863505;50454;50822;51110.488895110946;9553.665621703207;9691.321607487549;9734.9026509734;9744.123028927288;9896.653617123366;16526.364199876247;16830.495085147464;16844.39978202069;16852.91573542149;16903.32386704518;6293.653849038347;6317.557770956081;6530.706118224692;6615.702293396808;6653.135092438049;3509.94735078974;3602.2435288589168;3646.2889736501656;3655.3968595182027;3701.5188025556504;2759.696433392325;2832.079574138413;2844.1467559731996;2853.700361462058;2856.1431570528757;460.3118338084518;464.5563486870031;470.54122230825357;470.7457972694775;478.8698671136116;458.57352662024635;465.0304115918348;484.34371426716996;534.4228233507803;540.513537815961;7417.221191774786;7484.513506622161;7719.536827790351;7722.92277077222;7778.533288002738;509.19490406509016;521.2051621277582;524.4336116993637;591.1398914579277;607.8662694207268;3472;3611.5846677632408;3624.9456258156147;3781.1303400218103;3822.3884178531302;58615.41384586185;63282.68358658177;63493;63618.68190659017;65664;35771;36309.63690363063;36513.81743091268;55218.72390638101;57912.710436447545;52203.21695174575;53143.73428132835;54238.47449915822;54769.1784623231;54942;7004.614746189009;7214.134303883568;7369.926300737138;7383.926160738324;7400.370968467741;36230;36918.26163476769;37541.2491750158;37732;37810;46126.769366152956;47680.28479572879;47853.76073119612;48008.5199148018;49976;9097.909020909707;9173.54132293396;9210.309226807882;9271.443713377219;9607.759806004906;9963.750906227402;9981.850272245776;10009.54957026921;10040;10123.190144788547;8967.775805604912;9154.359194856295;9186.954065229631;9197.540122993958;9322.673706420243;9164.725058248263;9179.724608261762;9564.378315409476;9745.463999480096;10084.193264538966;9086.681966131153;9173.40372875761;9262.72211833646;9297.767555811159;9381.249500039843;7464.888026679713;7832.569208693349;7836.216378362118;7866.213378662317;7896.249856263646;7805.765827024971;7844.21557844211;8030.317423019109;8053;8275.462094963808 09:22:49 INFO - PROCESS | 6934 | __end_tp_report 09:22:49 INFO - PROCESS | 6934 | __start_cc_report 09:22:49 INFO - PROCESS | 6934 | _x_x_mozilla_cycle_collect,357 09:22:49 INFO - PROCESS | 6934 | __end_cc_report 09:22:49 INFO - PROCESS | 6934 | __startTimestamp1479489769340__endTimestamp 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | ------- Summary: start ------- 09:22:49 INFO - PROCESS | 6934 | Number of tests: 6 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | [#0] dojo.html Cycles:165 Average:4583.29 Median:4700.25 stddev:473.65 (10.1%) stddev-sans-first:447.75 09:22:49 INFO - PROCESS | 6934 | Values: 2561.1 2591.1 2591.7 2611.1 2629.6 4451.4 4556.7 4597.4 4616.2 4647.7 4509.1 4627.3 4658.8 4694.2 4694.5 4303.2 4327.6 4407.9 4415.1 4468.3 4301.2 4339.5 4353.3 4403.9 4432.4 4187.2 4214.5 4260.9 4300.4 4326.1 4271.6 4279.7 4304.1 4332.0 4356.4 4246.2 4279.4 4300.4 4321.3 4332.0 4481.2 4485.0 4614.4 4630.1 4638.1 4945.6 4963.4 5018.2 5022.6 5080.6 5035.7 5049.9 5051.6 5058.9 5099.2 4548.2 4700.2 4717.6 4721.1 4743.2 4974.0 5033.9 5044.2 5053.0 5134.6 4847.3 4852.6 4852.8 4867.6 4901.6 4839.4 4958.1 4964.9 4965.9 4969.1 4843.0 4865.6 4906.3 4907.7 4911.8 4870.4 4892.8 4915.6 4920.3 4956.5 4223.3 4240.8 4241.9 4245.2 4251.2 3639.2 3707.2 3707.4 3714.6 3746.4 4140.0 4156.7 4172.0 4201.4 4247.3 5023.2 5025.3 5034.8 5040.9 5076.5 4276.5 4298.7 4302.0 4313.2 4340.2 4323.9 4363.0 4419.6 4461.1 4511.4 4648.0 4663.9 4671.6 4683.4 4715.7 4936.2 4950.7 4951.3 4952.7 4978.2 4502.3 4550.7 4552.9 4639.7 4694.1 4781.8 4828.8 4845.2 4851.2 4889.8 4921.2 4934.8 4936.4 4936.9 4957.6 4926.4 4936.1 4938.5 4942.3 4963.1 4723.5 4732.7 4756.8 4774.7 4943.8 4720.5 4729.2 4741.2 4746.5 4750.0 4677.1 4765.1 4781.9 4833.0 4833.2 4698.0 4704.0 4715.5 4745.4 4788.8 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | [#1] ext.html Cycles:180 Average:43992.08 Median:19836.25 stddev:75865.68 (382.5%) stddev-sans-first:76008.28 09:22:49 INFO - PROCESS | 6934 | Values: 515.6 536.9 545.5 558.5 564.6 27860.0 30194.4 30228.7 38725.4 39482.2 38649.4 39198.2 39452.0 39490.0 39516.2 7409.0 7507.8 7563.8 7571.6 7581.1 7456.9 7574.7 7578.0 7579.5 7589.8 7534.3 7556.2 7569.1 7572.6 7574.9 7507.5 7535.4 7542.7 7553.4 7564.4 7464.3 7509.8 7509.9 7520.4 7529.9 36062.0 36516.6 36723.3 36726.3 36785.6 2935.9 2983.0 3047.8 3172.5 3177.5 27704.4 28021.2 28100.7 28245.6 28655.1 3424.2 3514.9 3531.7 3610.5 3664.2 233188.0 234144.0 235538.0 235712.0 236667.0 49277.8 49459.0 49498.5 49629.3 49657.5 52944.0 53096.7 53103.5 53140.5 53204.5 13517.6 13965.2 14020.4 14024.1 14025.0 9499.4 9621.7 9624.9 9641.7 9668.7 15204.0 15216.7 15234.2 15450.8 15629.8 5386.7 5503.2 5505.9 5616.4 5649.4 767.6 910.9 921.0 964.5 988.6 26516.9 27076.5 27144.6 27215.5 27611.3 775.0 903.9 917.8 938.4 982.9 13190.8 14156.6 14224.6 14227.7 14404.6 326191.0 327649.5 328573.0 328689.0 328874.0 46894.3 46963.0 47005.0 47023.5 47206.8 1134.1 1163.2 1168.6 1173.4 1174.6 24852.6 25603.5 25895.4 26761.3 26887.5 39870.8 40100.8 40118.4 40221.4 40242.8 295420.0 296945.0 297022.0 297681.0 299122.0 33794.8 34810.8 35534.3 35595.3 35636.5 40637.0 40786.6 40791.1 41307.8 41325.6 34858.5 35058.1 35128.8 35512.6 36005.8 34605.8 34735.3 34736.0 34807.8 34994.7 31179.7 34232.8 34541.1 34959.4 37463.8 29521.6 31768.8 31843.0 32271.7 32302.5 24433.0 24854.3 24901.4 25034.4 25292.7 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | [#2] jquery.html Cycles:180 Average:23255.97 Median:5268.70 stddev:63254.12 (1200.6%) stddev-sans-first:63408.11 09:22:49 INFO - PROCESS | 6934 | Values: 315.8 330.7 331.0 337.4 346.5 15543.9 15608.0 16991.8 17020.3 17112.7 15315.6 15411.6 15913.0 15923.0 16052.8 4784.4 4837.3 5018.4 5043.0 5068.1 4987.8 5082.6 5092.9 5101.0 5103.3 4965.3 5067.3 5070.6 5080.4 5252.6 5210.4 5286.1 5287.6 5288.4 5296.5 5064.6 5113.4 5167.7 5284.8 5316.9 11592.5 11813.5 11820.5 11839.3 15151.5 1716.6 1873.7 2012.9 2074.5 2167.6 8619.7 8732.5 8895.5 8915.6 9071.9 1655.6 1719.4 1747.1 1775.3 1777.9 38015.4 39362.2 41500.8 71545.6 73604.0 9213.6 9280.4 9291.2 9407.3 9619.4 12819.2 12823.4 12860.2 12868.1 12884.7 6553.2 6939.1 7070.8 7149.2 7153.1 6628.4 6638.8 6689.6 6853.7 6903.2 3883.0 3925.8 3943.3 3988.3 4125.1 1663.7 1745.6 1760.3 1762.6 1804.4 755.2 766.9 887.7 907.5 910.8 15851.3 15884.8 16534.5 16958.6 17292.4 807.7 821.4 821.6 835.9 840.1 8963.4 9586.5 9674.3 9706.7 9744.0 377085.0 380122.0 384289.0 387641.0 387824.0 73951.6 75207.0 76589.6 76642.2 76676.0 867.9 893.2 931.4 934.3 938.7 15454.3 15460.8 15646.5 15795.9 16193.8 37922.0 38284.4 39481.6 39532.4 39583.0 53669.2 53676.5 53702.5 54837.7 54940.7 6746.4 6845.7 7080.9 7164.7 7465.3 9921.3 10592.8 10821.9 10865.2 10905.0 9631.6 9632.9 9771.4 9891.1 9986.7 9260.3 9370.0 9404.2 9696.5 9963.8 9298.3 9650.7 9664.5 9707.2 9818.0 6977.3 7091.9 7154.2 7157.8 7301.0 7842.9 9436.2 9449.6 9610.9 9896.7 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | [#3] mootools.html Cycles:180 Average:4757.95 Median:5681.07 stddev:2568.06 (45.2%) stddev-sans-first:2562.34 09:22:49 INFO - PROCESS | 6934 | Values: 1329.6 1353.9 1421.7 1606.4 1645.5 6293.2 6501.1 6714.0 7189.6 7196.2 6812.5 7061.4 7076.8 7078.6 7219.3 2051.9 2102.9 2107.4 2117.9 2119.2 2083.5 2106.1 2168.9 2171.8 2172.4 2072.8 2112.0 2116.3 2146.5 2147.3 2003.9 2029.2 2029.7 2031.3 2032.0 2060.9 2066.3 2079.8 2094.1 2096.5 7108.5 7128.9 7168.2 7198.4 7212.4 4194.9 4310.3 4316.2 4327.0 4333.7 2799.3 2808.8 2852.7 2855.9 2868.8 846.3 878.3 900.9 912.9 938.3 9212.2 9386.7 9410.2 9456.6 9466.0 3675.8 3863.9 3927.2 3927.2 3933.7 8214.3 8240.8 8247.2 8285.5 8293.2 4316.8 4323.2 4359.5 4361.6 4377.7 3438.0 3553.5 3857.8 3866.5 3948.3 3335.7 3344.9 3412.4 3456.3 3473.7 1091.4 1102.6 1112.4 1130.5 1149.6 629.4 709.8 791.8 795.3 829.2 4856.6 4897.5 4932.7 5124.9 5304.5 771.6 771.9 796.4 801.0 827.5 3313.0 3318.7 3369.0 3400.1 3410.3 8293.8 8780.6 8786.5 8787.3 8794.0 8703.2 8720.0 8726.6 8731.7 8746.3 6517.8 6794.1 6798.7 6803.9 6825.1 4949.2 4964.7 4981.9 5113.5 5279.3 7741.5 7914.4 7985.9 8065.6 8103.5 8115.7 8118.8 8161.3 8206.0 8214.3 5644.5 5833.2 6088.5 6232.1 6243.3 6624.0 6935.1 6937.2 6937.6 7085.6 6282.0 6429.1 6513.6 6632.5 6735.7 6452.5 6524.5 6559.5 6580.9 6653.3 5717.6 5775.2 5822.9 5829.4 5903.4 4314.7 4412.9 4506.0 4561.3 4619.4 4576.3 4580.0 4657.3 4676.3 4841.4 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | [#4] prototype.html Cycles:180 Average:4194.08 Median:4743.37 stddev:1233.43 (26.0%) stddev-sans-first:1201.40 09:22:49 INFO - PROCESS | 6934 | Values: 280.3 280.9 288.9 289.1 291.4 4774.2 4831.9 4950.2 4976.3 4997.5 4728.3 4771.2 4866.6 4890.8 4892.9 3790.5 3808.4 3819.6 3824.4 3862.8 3709.6 3824.4 3829.2 3834.6 3839.3 3794.2 3801.1 3805.2 3813.5 3814.9 3813.0 3814.8 3816.6 3818.4 3850.9 3154.8 3265.2 3349.5 3365.8 3396.6 4735.3 4745.0 4752.0 4756.3 4767.7 4252.9 4284.6 4284.6 4285.8 4291.5 4935.9 5083.7 5098.5 5101.5 5101.7 3550.8 3579.1 3581.4 3584.6 3594.1 5359.3 5371.3 5382.7 5384.7 5387.4 3633.8 3640.3 3657.7 3663.4 3663.5 3474.3 3664.6 3688.5 3712.7 3717.5 4237.6 4247.2 4259.3 4259.4 4266.5 5112.7 5126.4 5129.5 5195.5 5201.4 1175.8 1176.4 1208.8 1250.4 1259.8 828.2 847.3 847.7 849.3 855.1 4264.8 4274.4 4281.7 4337.2 4353.6 5088.9 5095.6 5102.3 5115.5 5143.7 4200.8 4309.4 4311.7 4331.4 4358.5 2664.0 2669.8 2676.7 2678.7 2686.8 4708.2 4715.9 4728.3 4734.3 4753.2 4831.7 5047.2 5125.4 5136.4 5167.9 4728.8 4732.1 4738.8 4741.6 4741.7 5024.3 5044.2 5062.6 5065.3 5065.4 4989.7 5207.3 5214.7 5223.9 5231.4 5001.4 5015.1 5025.6 5026.7 5036.3 3651.9 3667.8 3687.2 3694.5 3696.0 5188.4 5238.4 5251.6 5270.6 5356.6 5101.8 5133.5 5141.9 5143.8 5159.8 5080.6 5176.8 5187.9 5203.7 5232.8 4795.9 4940.2 5040.2 5063.0 5068.1 5003.2 5116.9 5155.4 5161.6 5171.6 5055.9 5056.2 5058.1 5059.2 5080.4 09:22:49 INFO - PROCESS | 6934 | 09:22:49 INFO - PROCESS | 6934 | [#5] yui.html Cycles:180 Average:13494.96 Median:29603.28 stddev:17061.38 (57.6%) stddev-sans-first:17081.87 09:22:49 INFO - PROCESS | 6934 | Values: 624.9 648.6 684.1 726.7 749.0 12122.7 12911.9 12964.9 13000.3 13072.2 12108.8 12276.5 12289.5 12289.9 12368.4 753.4 761.5 775.3 790.7 797.1 786.4 787.8 788.0 788.3 788.7 835.7 836.3 837.1 837.5 839.3 820.6 824.9 825.6 827.6 833.4 601.6 601.7 602.3 602.5 604.7 12839.4 12846.9 12918.4 12944.9 12996.5 11678.6 11922.9 11981.8 11997.0 12251.2 8059.7 8103.4 10106.7 10221.6 10497.5 3122.4 3158.2 3176.1 3188.1 3221.7 48487.8 48632.5 50454.0 50822.0 51110.5 9553.7 9691.3 9734.9 9744.1 9896.7 16526.4 16830.5 16844.4 16852.9 16903.3 6293.7 6317.6 6530.7 6615.7 6653.1 3509.9 3602.2 3646.3 3655.4 3701.5 2759.7 2832.1 2844.1 2853.7 2856.1 460.3 464.6 470.5 470.7 478.9 458.6 465.0 484.3 534.4 540.5 7417.2 7484.5 7719.5 7722.9 7778.5 509.2 521.2 524.4 591.1 607.9 3472.0 3611.6 3624.9 3781.1 3822.4 58615.4 63282.7 63493.0 63618.7 65664.0 35771.0 36309.6 36513.8 55218.7 57912.7 52203.2 53143.7 54238.5 54769.2 54942.0 7004.6 7214.1 7369.9 7383.9 7400.4 36230.0 36918.3 37541.2 37732.0 37810.0 46126.8 47680.3 47853.8 48008.5 49976.0 9097.9 9173.5 9210.3 9271.4 9607.8 9963.8 9981.9 10009.5 10040.0 10123.2 8967.8 9154.4 9187.0 9197.5 9322.7 9164.7 9179.7 9564.4 9745.5 10084.2 9086.7 9173.4 9262.7 9297.8 9381.2 7464.9 7832.6 7836.2 7866.2 7896.2 7805.8 7844.2 8030.3 8053.0 8275.5 09:22:49 INFO - PROCESS | 6934 | -------- Summary: end -------- 09:22:49 INFO - PROCESS | 6934 | 09:22:50 INFO - TEST-INFO | 6934: exit 0 09:22:50 INFO - TEST-OK | dromaeo_css | took 1119863ms 09:22:50 INFO - TEST-START | kraken 09:22:50 INFO - operating with platform_type : linux_ 09:22:50 INFO - Initialising browser for kraken test... 09:22:50 INFO - TEST-INFO | started process 7299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwtkHcU/profile http://localhost:49814/getInfo.html) 09:22:54 INFO - PROCESS | 7299 | __metrics Screen width/height:1600/1200 09:22:54 INFO - PROCESS | 7299 | colorDepth:24 09:22:54 INFO - PROCESS | 7299 | Browser inner width/height: 1024/697 09:22:54 INFO - PROCESS | 7299 | __metrics 09:22:55 ERROR - PROCESS | 7299 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 09:22:56 INFO - TEST-INFO | 7299: exit 0 09:22:56 INFO - Browser initialized. 09:22:56 INFO - Running cycle 1/1 for kraken test... 09:22:56 INFO - TEST-INFO | started process 7420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwtkHcU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:08 INFO - PROCESS | 7420 | RSS: Main: 188342272 09:23:08 INFO - PROCESS | 7420 | 09:23:12 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49814/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:13 INFO - PROCESS | 7420 | RSS: Main: 201138176 09:23:13 INFO - PROCESS | 7420 | 09:23:15 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49814/tests/kraken/driver.html?testName=audio-dft) 09:23:16 INFO - PROCESS | 7420 | RSS: Main: 199090176 09:23:16 INFO - PROCESS | 7420 | 09:23:19 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49814/tests/kraken/driver.html?testName=audio-fft) 09:23:20 INFO - PROCESS | 7420 | RSS: Main: 195735552 09:23:20 INFO - PROCESS | 7420 | 09:23:22 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49814/tests/kraken/driver.html?testName=audio-oscillator) 09:23:22 INFO - PROCESS | 7420 | RSS: Main: 195747840 09:23:22 INFO - PROCESS | 7420 | 09:23:25 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:25 INFO - PROCESS | 7420 | RSS: Main: 195903488 09:23:25 INFO - PROCESS | 7420 | 09:23:28 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49814/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:29 INFO - PROCESS | 7420 | RSS: Main: 201162752 09:23:29 INFO - PROCESS | 7420 | 09:23:33 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49814/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:33 INFO - PROCESS | 7420 | RSS: Main: 197160960 09:23:33 INFO - PROCESS | 7420 | 09:23:36 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49814/tests/kraken/driver.html?testName=json-parse-financial) 09:23:37 INFO - PROCESS | 7420 | RSS: Main: 198090752 09:23:37 INFO - PROCESS | 7420 | 09:23:39 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:39 INFO - PROCESS | 7420 | RSS: Main: 198180864 09:23:39 INFO - PROCESS | 7420 | 09:23:41 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:42 INFO - PROCESS | 7420 | RSS: Main: 198193152 09:23:42 INFO - PROCESS | 7420 | 09:23:44 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:45 INFO - PROCESS | 7420 | RSS: Main: 198561792 09:23:45 INFO - PROCESS | 7420 | 09:23:48 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:48 INFO - PROCESS | 7420 | RSS: Main: 198873088 09:23:48 INFO - PROCESS | 7420 | 09:23:51 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:52 INFO - PROCESS | 7420 | RSS: Main: 198909952 09:23:52 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | Cycle 1(1): loaded http://localhost:49814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49814/tests/kraken/driver.html?testName=ai-astar) 09:23:54 INFO - PROCESS | 7420 | RSS: Main: 201662464 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | __start_tp_report 09:23:54 INFO - PROCESS | 7420 | _x_x_mozilla_page_load 09:23:54 INFO - PROCESS | 7420 | _x_x_mozilla_page_load_details 09:23:54 INFO - PROCESS | 7420 | |i|pagename|runs| 09:23:54 INFO - PROCESS | 7420 | |0;ai-astar;109;118;117;118;117;118;120;117;116;119 09:23:54 INFO - PROCESS | 7420 | |1;audio-beat-detection;158;130;130;179;142;131;131;133;162;137 09:23:54 INFO - PROCESS | 7420 | |2;audio-dft;167;162;164;165;165;163;165;162;168;168 09:23:54 INFO - PROCESS | 7420 | |3;audio-fft;78;76;78;105;79;79;77;78;100;76 09:23:54 INFO - PROCESS | 7420 | |4;audio-oscillator;86;84;109;87;85;85;116;84;83;122 09:23:54 INFO - PROCESS | 7420 | |5;imaging-gaussian-blur;119;118;128;117;118;120;120;118;118;118 09:23:54 INFO - PROCESS | 7420 | |6;imaging-darkroom;149;149;150;148;148;150;149;148;147;149 09:23:54 INFO - PROCESS | 7420 | |7;imaging-desaturate;96;96;96;97;96;95;96;98;96;96 09:23:54 INFO - PROCESS | 7420 | |8;json-parse-financial;67;67;68;64;67;68;68;68;67;66 09:23:54 INFO - PROCESS | 7420 | |9;json-stringify-tinderbox;66;69;65;67;66;66;68;66;66;66 09:23:54 INFO - PROCESS | 7420 | |10;stanford-crypto-aes;89;92;87;86;85;95;88;87;94;87 09:23:54 INFO - PROCESS | 7420 | |11;stanford-crypto-ccm;162;175;162;145;147;156;159;153;195;158 09:23:54 INFO - PROCESS | 7420 | |12;stanford-crypto-pbkdf2;181;181;182;185;179;180;178;181;179;181 09:23:54 INFO - PROCESS | 7420 | |13;stanford-crypto-sha256-iterative;72;69;72;71;75;75;71;72;71;70 09:23:54 INFO - PROCESS | 7420 | __end_tp_report 09:23:54 INFO - PROCESS | 7420 | __start_cc_report 09:23:54 INFO - PROCESS | 7420 | _x_x_mozilla_cycle_collect,896 09:23:54 INFO - PROCESS | 7420 | __end_cc_report 09:23:54 INFO - PROCESS | 7420 | __startTimestamp1479489834674__endTimestamp 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | ------- Summary: start ------- 09:23:54 INFO - PROCESS | 7420 | Number of tests: 14 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#0] ai-astar Cycles:10 Average:116.90 Median:118.00 stddev:3.00 (2.5%) stddev-sans-first:1.20 09:23:54 INFO - PROCESS | 7420 | Values: 109.0 118.0 117.0 118.0 117.0 118.0 120.0 117.0 116.0 119.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:139.50 stddev:17.14 (12.3%) stddev-sans-first:17.33 09:23:54 INFO - PROCESS | 7420 | Values: 158.0 130.0 130.0 179.0 142.0 131.0 131.0 133.0 162.0 137.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.23 (1.4%) stddev-sans-first:2.24 09:23:54 INFO - PROCESS | 7420 | Values: 167.0 162.0 164.0 165.0 165.0 163.0 165.0 162.0 168.0 168.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#3] audio-fft Cycles:10 Average:82.60 Median:78.00 stddev:10.61 (13.6%) stddev-sans-first:11.12 09:23:54 INFO - PROCESS | 7420 | Values: 78.0 76.0 78.0 105.0 79.0 79.0 77.0 78.0 100.0 76.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.50 stddev:15.23 (18.0%) stddev-sans-first:15.87 09:23:54 INFO - PROCESS | 7420 | Values: 86.0 84.0 109.0 87.0 85.0 85.0 116.0 84.0 83.0 122.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:118.50 stddev:3.17 (2.7%) stddev-sans-first:3.36 09:23:54 INFO - PROCESS | 7420 | Values: 119.0 118.0 128.0 117.0 118.0 120.0 120.0 118.0 118.0 118.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:23:54 INFO - PROCESS | 7420 | Values: 149.0 149.0 150.0 148.0 148.0 150.0 149.0 148.0 147.0 149.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:23:54 INFO - PROCESS | 7420 | Values: 96.0 96.0 96.0 97.0 96.0 95.0 96.0 98.0 96.0 96.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 09:23:54 INFO - PROCESS | 7420 | Values: 67.0 67.0 68.0 64.0 67.0 68.0 68.0 68.0 67.0 66.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 09:23:54 INFO - PROCESS | 7420 | Values: 66.0 69.0 65.0 67.0 66.0 66.0 68.0 66.0 66.0 66.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:88.50 stddev:3.46 (3.9%) stddev-sans-first:3.67 09:23:54 INFO - PROCESS | 7420 | Values: 89.0 92.0 87.0 86.0 85.0 95.0 88.0 87.0 94.0 87.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#11] stanford-crypto-ccm Cycles:10 Average:161.20 Median:160.50 stddev:14.56 (9.1%) stddev-sans-first:15.44 09:23:54 INFO - PROCESS | 7420 | Values: 162.0 175.0 162.0 145.0 147.0 156.0 159.0 153.0 195.0 158.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:181.00 stddev:1.95 (1.1%) stddev-sans-first:2.06 09:23:54 INFO - PROCESS | 7420 | Values: 181.0 181.0 182.0 185.0 179.0 180.0 178.0 181.0 179.0 181.0 09:23:54 INFO - PROCESS | 7420 | 09:23:54 INFO - PROCESS | 7420 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.93 (2.7%) stddev-sans-first:2.05 09:23:54 INFO - PROCESS | 7420 | Values: 72.0 69.0 72.0 71.0 75.0 75.0 71.0 72.0 71.0 70.0 09:23:54 INFO - PROCESS | 7420 | -------- Summary: end -------- 09:23:54 INFO - PROCESS | 7420 | 09:23:55 INFO - TEST-INFO | 7420: exit 0 09:23:55 INFO - TEST-OK | kraken | took 65505ms 09:23:55 INFO - SUITE-END | took 1185s 09:23:56 INFO - Completed test suite (00:19:45) 09:23:56 INFO - javascript benchmark 09:23:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6068.350639810403, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.142017424163, 2591.1060684064005, 2591.650127232823, 2611.1122218445726, 2629.5792673172296, 4451.376807246988, 4556.749378784161, 4597.448306203256, 4616.169089563886, 4647.651426143036, 4509.098180363924, 4627.305904114384, 4658.79035443405, 4694.201985662437, 4694.4601370842365, 4303.24693178694, 4327.567243275679, 4407.911841763163, 4415.072834704716, 4468.285074388098, 4301.225779359714, 4339.522652508222, 4353.346997950317, 4403.933940990888, 4432.3794668746405, 4187.246295666779, 4214.536400995888, 4260.893477663052, 4300.397944287803, 4326.113146804929, 4271.572842715735, 4279.700420970534, 4304.117655880537, 4331.956680433187, 4356.43366362374, 4246.214450326699, 4279.40088387626, 4300.419443375135, 4321.308590625485, 4332.0469496710675, 4481.170983368054, 4484.955150448486, 4614.423197100363, 4630.143423466636, 4638.072385522909, 4945.579625731817, 4963.40439147301, 5018.197088465864, 5022.6233032522705, 5080.618953578496, 5035.672681275742, 5049.949500504985, 5051.646384753032, 5058.873528161788, 5099.235114732783, 4548.1813273610405, 4700.247960326331, 4717.599004084623, 4721.102990431807, 4743.169945259566, 4973.975130124399, 5033.924491132636, 5044.218146187347, 5052.974735126374, 5134.5635620972635, 4847.297141914402, 4852.636052296092, 4852.781624826891, 4867.571236084618, 4901.558859702573, 4839.370881785416, 4958.082754690394, 4964.925526117111, 4965.90068198634, 4969.0807200668, 4842.951570484321, 4865.635077369211, 4906.31311616374, 4907.7300748458465, 4911.803527858917, 4870.4155501339355, 4892.804287828447, 4915.631327650441, 4920.286558449005, 4956.4547899731, 4223.282042052859, 4240.766757828287, 4241.936370954438, 4245.1934132514725, 4251.192273468031, 3639.181184233579, 3707.2029513654693, 3707.4068149096556, 3714.609965953536, 3746.3818469952153, 4139.985703502661, 4156.688248381383, 4171.958280417218, 4201.390798334285, 4247.320428731388, 5023.246513023003, 5025.346704928409, 5034.8237811677145, 5040.924386134211, 5076.492350764968, 4276.5295817460055, 4298.699091063658, 4302.0, 4313.202057619351, 4340.175366680321, 4323.870283891425, 4362.9781851091175, 4419.64642828573, 4461.063176732922, 4511.390962220124, 4648.047150334241, 4663.906721865475, 4671.579557839811, 4683.391159149289, 4715.6699031068865, 4936.185529387611, 4950.6782059166035, 4951.306817045544, 4952.653314267966, 4978.178600530872, 4502.3471596618965, 4550.658700597534, 4552.908941821212, 4639.698419602715, 4694.084653492536, 4781.832635857728, 4828.806847726192, 4845.1520983828395, 4851.151048566558, 4889.828855990023, 4921.188003979303, 4934.827281045146, 4936.358273424576, 4936.9259461107395, 4957.553820156203, 4926.359573255454, 4936.0868239374395, 4938.481459446706, 4942.258661200849, 4963.057019166491, 4723.527647235249, 4732.73969931657, 4756.762161891822, 4774.737389443475, 4943.802247910044, 4720.45714742809, 4729.219678752967, 4741.217699079613, 4746.5490778376, 4750.049990001944, 4677.087967846237, 4765.142274390643, 4781.856544303677, 4832.975835120802, 4833.2025215840395, 4697.976510117564, 4704.0, 4715.528447155394, 4745.38310019709, 4788.832390866303], "value": 4553.442924031826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.6442054982062, 536.895305415444, 545.5090418623241, 558.5419955636377, 564.5737468211499, 27860.0, 30194.39611207777, 30228.697713022862, 38725.41911871317, 39482.210355792864, 38649.420258696075, 39198.21603567927, 39452.0, 39490.0, 39516.20967580654, 7409.036825212728, 7507.849843003164, 7563.848723025536, 7571.583562904038, 7581.09026916768, 7456.850862982737, 7574.697012119509, 7577.962110189469, 7579.545227286353, 7589.848203035936, 7534.284242996907, 7556.2443755624545, 7569.129550101727, 7572.583507907063, 7574.886376704354, 7507.512011719248, 7535.3594944429515, 7542.660580273846, 7553.395728341774, 7564.432667549956, 7464.290892365217, 7509.774706758806, 7509.924900750977, 7520.398368130536, 7529.9247007529775, 36062.0, 36516.63483365186, 36723.265534689155, 36726.26547469036, 36785.632143678486, 2935.9412811743646, 2982.9552556711665, 3047.832369219692, 3172.460681684119, 3177.523371494294, 27704.445911081868, 28021.159365219075, 28100.71899281022, 28245.576316355273, 28655.14034578966, 3424.2466657335344, 3514.912127196815, 3531.699805516534, 3610.492932853401, 3664.157243833933, 233188.0, 234144.0, 235538.0, 235712.0, 236667.0, 49277.75361123243, 49459.0, 49498.50501495011, 49629.25556116661, 49657.50342496529, 52944.0, 53096.73451632717, 53103.468965310625, 53140.46859531433, 53204.467955320724, 13517.59447216585, 13965.23191224472, 14020.369083391271, 14024.08843425174, 14025.0, 9499.43003419797, 9621.663241786504, 9624.903750962401, 9641.710748677551, 9668.661596844076, 15204.0, 15216.695666086616, 15234.238288085551, 15450.768238476432, 15629.843701563066, 5386.730663466811, 5503.220873458958, 5505.889882202334, 5616.354119276254, 5649.406812284733, 767.5855038279378, 910.8906931168169, 920.9953950230206, 964.4513751626379, 988.6342053440274, 26516.867415662797, 27076.458470830472, 27144.592831107548, 27215.45569088647, 27611.30971725723, 774.9576819178196, 903.8734577159203, 917.7613820406742, 938.4134915677702, 982.9017098290113, 13190.823514120062, 14156.575302740934, 14224.644383890278, 14227.715445691028, 14404.567862964128, 326191.0, 327649.53226636956, 328573.0, 328689.0, 328874.0, 46894.296585551245, 46963.0, 47005.0, 47023.5297647026, 47206.76396618064, 1134.0927258193412, 1163.2206421697483, 1168.59099315239, 1173.4250217393417, 1174.5947648061406, 24852.627210591494, 25603.487930240917, 25895.35261618399, 26761.33096672599, 26887.462250755267, 39870.80064599775, 40100.799496002335, 40118.39822402608, 40221.39667905042, 40242.798786005886, 295420.0, 296945.0, 297022.0, 297681.0, 299122.0, 33794.831025844716, 34810.82594587011, 35534.28931421409, 35595.288094237454, 35636.46545301875, 40637.0, 40786.59213407947, 40791.112390157454, 41307.7934610325, 41325.586744132175, 34858.47712284267, 35058.123546911535, 35128.82435587806, 35512.644873551966, 36005.819970899975, 34605.82697086498, 34735.30529389449, 34736.0, 34807.82596087003, 34994.650053500154, 31179.688203118585, 34232.82883585666, 34541.13647158841, 34959.40649496068, 37463.81268093642, 29521.557176641938, 31768.841155794074, 31843.0, 32271.67728322687, 32302.515462267616, 24433.0, 24854.254372368858, 24901.377465563506, 25034.3741406459, 25292.74707252904], "value": 16740.330522904736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.8073575119178, 330.712280316125, 330.95863017122855, 337.42132243202934, 346.4543344232834, 15543.922280388611, 15608.0, 16991.83008169918, 17020.31918723251, 17112.743308850346, 15315.617109572266, 15411.614709632266, 15913.0, 15923.0, 16052.759208611851, 4784.378030855993, 4837.250226214942, 5018.372703412074, 5042.974785126069, 5068.1130802109665, 4987.75061246938, 5082.593392528589, 5092.9236061459105, 5101.0, 5103.336566246383, 4965.28003439501, 5067.315912351841, 5070.594352451795, 5080.390353157626, 5252.606054545905, 5210.374755029402, 5286.101362768339, 5287.629865909388, 5288.391834938992, 5296.496832800878, 5064.56951159152, 5113.386393632751, 5167.6641018333685, 5284.788608455658, 5316.9202461963105, 11592.47833847479, 11813.468393922294, 11820.527178912833, 11839.348835814028, 15151.469698560497, 1716.6395057038037, 1873.653374125791, 2012.8691635043676, 2074.5332300232476, 2167.6206663833764, 8619.698310559163, 8732.51971141587, 8895.510746908918, 8915.55422228886, 9071.909280907239, 1655.635760132781, 1719.4173694009482, 1747.0931386166008, 1775.254393154865, 1777.9377721779676, 38015.42976855349, 39362.21275574501, 41500.79249603733, 71545.64227178883, 73604.0, 9213.631454741735, 9280.443173409618, 9291.234665413549, 9407.341486095907, 9619.422834629944, 12819.16675416095, 12823.35883205836, 12860.164089334163, 12868.099233053783, 12884.742305153844, 6553.246376666744, 6939.063226464464, 7070.823229419203, 7149.177844547839, 7153.070100886852, 6628.403443689995, 6638.834029149213, 6689.632070236086, 6853.657317134123, 6903.1716194057035, 3882.9611703883165, 3925.803709814498, 3943.2704949584418, 3988.262171498282, 4125.1131006833675, 1663.708850951103, 1745.5810605454599, 1760.313477743681, 1762.5857923387994, 1804.404546499652, 755.2447552447552, 766.8581312457213, 887.7070566712969, 907.4827348411342, 910.8497097978892, 15851.286692098884, 15884.841151588567, 16534.503964881074, 16958.550206299868, 17292.394766183123, 807.6567458829974, 821.4332110843499, 821.5645707774889, 835.8996920369473, 840.1220724343076, 8963.417377870417, 9586.520673966274, 9674.322797404115, 9706.660266890625, 9743.951280243695, 377085.0, 380122.0, 384289.0, 387641.0, 387824.0, 73951.63024184844, 75207.0, 76589.61705191438, 76642.23357766462, 76676.0, 867.8568036273944, 893.2005854759954, 931.380631879806, 934.3272843552631, 938.6761567259284, 15454.304556294768, 15460.84539154639, 15646.452374166849, 15795.921020394824, 16193.75709364337, 37922.0, 38284.42573361346, 39481.605183948945, 39532.40701389424, 39583.0, 53669.19496207482, 53676.46323536715, 53702.462975369745, 54837.725811370685, 54940.72529637326, 6746.4265537429865, 6845.691943862438, 7080.929190708027, 7164.677589508589, 7465.328120469184, 9921.305508614329, 10592.788144236918, 10821.891781082404, 10865.18511111654, 10905.0, 9631.566579504079, 9632.9036709632, 9771.364861283993, 9891.109800118023, 9986.700398988041, 9260.259179265777, 9369.953150234205, 9404.153626173676, 9696.5151742414, 9963.750906227402, 9298.256139508689, 9650.662226822027, 9664.468454234804, 9707.174890134134, 9818.0, 6977.298693557281, 7091.858162836817, 7154.2130365658695, 7157.785266442015, 7301.0, 7842.9215707842195, 9436.150746432853, 9449.622015119317, 9610.855837162588, 9896.653617123366], "value": 7745.666998551244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.5612447892192, 1353.9458421663135, 1421.694335717821, 1606.3815431059038, 1645.4652238022645, 6293.24481062272, 6501.057346684728, 6713.966430167849, 7189.568625882444, 7196.208417074117, 6812.523123381353, 7061.435085193185, 7076.823079423017, 7078.646067696607, 7219.278072192791, 2051.907664155113, 2102.8633138846003, 2107.4415279950827, 2117.87292762434, 2119.1841141160685, 2083.479130217446, 2106.0838535237144, 2168.902399392031, 2171.8262538996923, 2172.424307558498, 2072.8134467897885, 2112.049577690038, 2116.3121985354746, 2146.5170336674278, 2147.31285988483, 2003.869748466345, 2029.2086086426232, 2029.736134302546, 2031.2788959919164, 2032.0, 2060.8866512341815, 2066.318115022039, 2079.8440116991137, 2094.099537199004, 2096.5282811367474, 7108.537945033608, 7128.9287107128785, 7168.175659799138, 7198.388137008361, 7212.423006159547, 4194.874153775361, 4310.28880234764, 4316.179925814085, 4327.0, 4333.674974376934, 2799.3281612412875, 2808.8314701117793, 2852.7147285271512, 2855.9428811423863, 2868.827870327787, 846.3483117999168, 878.284198378326, 900.8513595256775, 912.8676341930383, 938.3197182043033, 9212.170904618617, 9386.718398448058, 9410.153086222273, 9456.621735130586, 9466.0, 3675.834587443518, 3863.9227215455535, 3927.1752931884052, 3927.2341893330527, 3933.724639275223, 8214.301784348398, 8240.8351832963, 8247.21651443112, 8285.50286982783, 8293.21214484623, 4316.762578058237, 4323.178596066738, 4359.498657654347, 4361.6074553290355, 4377.715448495837, 3437.9656203438144, 3553.466979952976, 3857.787821669835, 3866.516685414323, 3948.3287841067086, 3335.6664333566932, 3344.88292909747, 3412.4369479036177, 3456.3087382523595, 3473.7394695397948, 1091.4270008245735, 1102.6306187427301, 1112.4215407987963, 1130.4517309105076, 1149.5918948773065, 629.4492319220682, 709.8367375503663, 791.782259878538, 795.3120550723582, 829.2453866981018, 4856.635752318591, 4897.4857639948, 4932.728699921467, 5124.871878203, 5304.549113325334, 771.5833449937084, 771.9498232614862, 796.366888323784, 801.0, 827.5489858027389, 3313.022658315803, 3318.6515415881468, 3369.039823650297, 3400.1329660936303, 3410.334984677964, 8293.751187464386, 8780.648774048967, 8786.516741579147, 8787.340949428819, 8794.0, 8703.216710496086, 8719.956400217958, 8726.607302671267, 8731.738047858575, 8746.338195742916, 6517.804465866032, 6794.116764820542, 6798.660066996729, 6803.9319606805275, 6825.078614386995, 4949.178114825685, 4964.702117872939, 4981.900361992667, 5113.51421614946, 5279.340082489689, 7741.458097933316, 7914.44598878073, 7985.880211796712, 8065.596720164086, 8103.473274237156, 8115.715949941724, 8118.83762324762, 8161.347092232489, 8206.0, 8214.34285257166, 5644.520215781705, 5833.154192642128, 6088.482478989158, 6232.096346029891, 6243.282022567463, 6624.006399040182, 6935.098437203132, 6937.236903940663, 6937.618430986142, 7085.57486550788, 6281.96859015702, 6429.067785171217, 6513.609183449008, 6632.4694024478895, 6735.730570777114, 6452.516061295328, 6524.543281970216, 6559.508036897157, 6580.868382632416, 6653.301403352578, 5717.628354156966, 5775.249217601685, 5822.94177058224, 5829.38791426911, 5903.350631430453, 4314.741115533078, 4412.9117417652105, 4506.008678090815, 4561.270196768501, 4619.376384188092, 4576.313552967082, 4579.9542004579525, 4657.300085468847, 4676.321933319718, 4841.394825646794], "value": 3874.008119141445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.29645589570174, 280.93819359740854, 288.8642338101092, 289.1470163019093, 291.3531959050909, 4774.212254977924, 4831.9275210871865, 4950.158473059584, 4976.253561965707, 4997.475265097167, 4728.267118596623, 4771.1888978873585, 4866.562009419152, 4890.779914903829, 4892.926606100911, 3790.4882840816413, 3808.447775072627, 3819.618038196186, 3824.445455408978, 3862.806859657013, 3709.610490898457, 3824.388097904336, 3829.195868867527, 3834.559025712037, 3839.34731095713, 3794.203217324365, 3801.1257410795533, 3805.2389522095555, 3813.523309586302, 3814.9046273843237, 3813.0, 3814.7520411173464, 3816.618338166175, 3818.4463252828186, 3850.8652197172964, 3154.794938329001, 3265.2326703224962, 3349.5478110455265, 3365.848536815849, 3396.607390969715, 4735.289706544046, 4745.0, 4752.006236071253, 4756.31033500144, 4767.737774422405, 4252.914941701149, 4284.571542845691, 4284.592963668447, 4285.849995250152, 4291.4850217973735, 4935.852903986777, 5083.669561478492, 5098.4646612105935, 5101.51535604117, 5101.744912754348, 3550.751447398683, 3579.0515513388973, 3581.3732596795717, 3584.6415358464205, 3594.101474631342, 5359.276497672803, 5371.274877891474, 5382.703951282678, 5384.703841288728, 5387.410713839387, 3633.7819730816236, 3640.2537479816574, 3657.6890964267805, 3663.3589121904092, 3663.5454245655474, 3474.270403215353, 3664.6152154023443, 3688.4836122942274, 3712.7401081924545, 3717.516722826015, 4237.63980061692, 4247.235497610398, 4259.3185090386005, 4259.446271984622, 4266.530681625019, 5112.667676601009, 5126.38483381989, 5129.512696293846, 5195.454477279907, 5201.401838788512, 1175.8118701007797, 1176.4176732517287, 1208.8186771984097, 1250.4310538704867, 1259.817326487654, 828.2173346187794, 847.3179090831816, 847.737201467547, 849.3332733803934, 855.1448551448551, 4264.829406823755, 4274.380214868826, 4281.678874084456, 4337.175936572041, 4353.564643535685, 5088.92120267233, 5095.592352611782, 5102.336696229467, 5115.514026167582, 5143.691378517301, 4200.768957707355, 4309.439772829513, 4311.736338422291, 4331.436913201263, 4358.476982762026, 2664.0, 2669.7730692891323, 2676.665416822897, 2678.691950425687, 2686.838789672626, 4708.199606066977, 4715.929261061086, 4728.3380326753595, 4734.289856521549, 4753.215719406328, 4831.73425461603, 5047.2429135629945, 5125.384953805493, 5136.409312928986, 5167.870803229875, 4728.810847566127, 4732.148213321635, 4738.763061846894, 4741.596964258077, 4741.739204343794, 5024.346834911438, 5044.167712327571, 5062.645614806928, 5065.341505604248, 5065.4428012917815, 4989.675671081368, 5207.3490813648295, 5214.713190774544, 5223.921641175461, 5231.398389185292, 5001.42483614389, 5015.097282489041, 5025.572826309804, 5026.698398095979, 5036.269740887624, 3651.8539258429364, 3667.8349474273186, 3687.2256826066828, 3694.482772411918, 3695.963040369562, 5188.403333616682, 5238.371395432572, 5251.606129540223, 5270.578353731616, 5356.57147428197, 5101.821436249714, 5133.537981581676, 5141.948580514147, 5143.8456846294675, 5159.819406320761, 5080.644354895122, 5176.757578181134, 5187.948120518747, 5203.687778733288, 5232.7645255964335, 4795.928061079157, 4940.160172770709, 5040.218766091261, 5062.974685126551, 5068.109274550077, 5003.174476211384, 5116.872078198075, 5155.43290238066, 5161.5805653445605, 5171.612129090258, 5055.898882022412, 5056.241563765465, 5058.064258112261, 5059.19052951526, 5080.441151473261], "value": 3794.664909098895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.8516965909989, 648.5881465269553, 684.1379861374667, 726.6657337624692, 748.9625518724064, 12122.69693257669, 12911.870881291185, 12964.870351296484, 13000.28498432587, 13072.21566705997, 12108.757824843498, 12276.508939642426, 12289.508419663225, 12289.877101228985, 12368.443420046096, 753.4236309223421, 761.4707778094213, 775.3138472451865, 790.7034861926777, 797.131127071492, 786.382689588673, 787.79123532264, 788.0464637788255, 788.3299195683652, 788.7081779741475, 835.6740871060291, 836.2849763452252, 837.0917554453395, 837.5100566168768, 839.2614499240659, 820.6143112737034, 824.9216324449168, 825.5624519004876, 827.5696637748338, 833.3666413525734, 601.6390165900468, 601.6660753281927, 602.325395556979, 602.4607975861624, 604.7157835817203, 12839.422225999853, 12846.935765321206, 12918.418671159727, 12944.935275323563, 12996.545120920817, 11678.591249306319, 11922.880771192264, 11981.820272695917, 11997.0, 12251.203671761306, 8059.677612895477, 8103.392245581605, 10106.696799096038, 10221.64224252155, 10497.527611257512, 3122.370013296222, 3158.2262345725217, 3176.142441540794, 3188.1232661018175, 3221.6617255188103, 48487.75756121197, 48632.513674863505, 50454.0, 50822.0, 51110.488895110946, 9553.665621703207, 9691.321607487549, 9734.9026509734, 9744.123028927288, 9896.653617123366, 16526.364199876247, 16830.495085147464, 16844.39978202069, 16852.91573542149, 16903.32386704518, 6293.653849038347, 6317.557770956081, 6530.706118224692, 6615.702293396808, 6653.135092438049, 3509.94735078974, 3602.2435288589168, 3646.2889736501656, 3655.3968595182027, 3701.5188025556504, 2759.696433392325, 2832.079574138413, 2844.1467559731996, 2853.700361462058, 2856.1431570528757, 460.3118338084518, 464.5563486870031, 470.54122230825357, 470.7457972694775, 478.8698671136116, 458.57352662024635, 465.0304115918348, 484.34371426716996, 534.4228233507803, 540.513537815961, 7417.221191774786, 7484.513506622161, 7719.536827790351, 7722.92277077222, 7778.533288002738, 509.19490406509016, 521.2051621277582, 524.4336116993637, 591.1398914579277, 607.8662694207268, 3472.0, 3611.5846677632408, 3624.9456258156147, 3781.1303400218103, 3822.3884178531302, 58615.41384586185, 63282.68358658177, 63493.0, 63618.68190659017, 65664.0, 35771.0, 36309.63690363063, 36513.81743091268, 55218.72390638101, 57912.710436447545, 52203.21695174575, 53143.73428132835, 54238.47449915822, 54769.1784623231, 54942.0, 7004.614746189009, 7214.134303883568, 7369.926300737138, 7383.926160738324, 7400.370968467741, 36230.0, 36918.26163476769, 37541.2491750158, 37732.0, 37810.0, 46126.769366152956, 47680.28479572879, 47853.76073119612, 48008.5199148018, 49976.0, 9097.909020909707, 9173.54132293396, 9210.309226807882, 9271.443713377219, 9607.759806004906, 9963.750906227402, 9981.850272245776, 10009.54957026921, 10040.0, 10123.190144788547, 8967.775805604912, 9154.359194856295, 9186.954065229631, 9197.540122993958, 9322.673706420243, 9164.725058248263, 9179.724608261762, 9564.378315409476, 9745.463999480096, 10084.193264538966, 9086.681966131153, 9173.40372875761, 9262.72211833646, 9297.767555811159, 9381.249500039843, 7464.888026679713, 7832.569208693349, 7836.216378362118, 7866.213378662317, 7896.249856263646, 7805.765827024971, 7844.21557844211, 8030.317423019109, 8053.0, 8275.462094963808], "value": 5752.773561722951, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 117.0, 118.0, 117.0, 118.0, 120.0, 117.0, 116.0, 119.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 130.0, 179.0, 142.0, 131.0, 131.0, 133.0, 162.0, 137.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 164.0, 165.0, 165.0, 163.0, 165.0, 162.0, 168.0, 168.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 105.0, 79.0, 79.0, 77.0, 78.0, 100.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 109.0, 87.0, 85.0, 85.0, 116.0, 84.0, 83.0, 122.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 128.0, 117.0, 118.0, 120.0, 120.0, 118.0, 118.0, 118.0], "value": 119.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 148.0, 148.0, 150.0, 149.0, 148.0, 147.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 64.0, 67.0, 68.0, 68.0, 68.0, 67.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 65.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 87.0, 86.0, 85.0, 95.0, 88.0, 87.0, 94.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 175.0, 162.0, 145.0, 147.0, 156.0, 159.0, 153.0, 195.0, 158.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 182.0, 185.0, 179.0, 180.0, 178.0, 181.0, 179.0, 181.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 72.0, 71.0, 75.0, 75.0, 71.0, 72.0, 71.0, 70.0], "value": 71.8, "unit": "score"}]}]} 09:23:56 INFO - Return code: 0 09:23:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:56 ERROR - # TBPL SUCCESS # 09:23:56 INFO - Running post-action listener: _resource_record_post_action 09:23:56 INFO - [mozharness: 2016-11-18 17:23:56.502237Z] Finished run-tests step (success) 09:23:56 INFO - Running post-run listener: _resource_record_post_run 09:23:56 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 12288; Write bytes: 402382848; Read time: 264; Write time: 285636 09:23:56 INFO - TinderboxPrint: CPU usage
13.4% 09:23:56 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 264 09:23:56 INFO - TinderboxPrint: I/O write bytes / time
402,382,848 / 285,636 09:23:56 INFO - TinderboxPrint: CPU idle
8,295.5 (86.5%) 09:23:56 INFO - TinderboxPrint: CPU user
1,229.5 (12.8%) 09:23:56 INFO - TinderboxPrint: Swap in / out
0 / 0 09:23:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110366720; Read time: 100; Write time: 64756 09:23:56 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292016128; Read time: 148; Write time: 220880 09:23:57 INFO - Running post-run listener: _upload_blobber_files 09:23:57 INFO - Blob upload gear active. 09:23:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:57 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 09:23:57 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'] 09:23:57 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 09:23:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:58 INFO - (blobuploader) - INFO - Done attempting. 09:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:59 INFO - (blobuploader) - INFO - Done attempting. 09:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:02 INFO - (blobuploader) - INFO - Done attempting. 09:24:02 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:02 INFO - Return code: 0 09:24:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8497271877ac797048e48c1d5f4e9d51021b47a6abb10053c05e4dba85f5bce58e0c12f54d352ada52c5028af4e51fc74bb3ecf6a010f17e3a1b9eece8de4d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e0ed7f349c3b524ec796e5f7e567485c68685b62526498ac1df1f14a114047928fa54a0b428606dcf14307fe53181e9de13eb3d521f6abff0e4470635a0893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df9b0b92bc8f7301b41f0ad741d9010f80edf52254963b7f1363b47cdf3c07f2ea545a711bf9f37fe06571b081ce4a8835fc200aed050ec257dc5a3c32fbd489"} 09:24:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:02 INFO - Contents: 09:24:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8497271877ac797048e48c1d5f4e9d51021b47a6abb10053c05e4dba85f5bce58e0c12f54d352ada52c5028af4e51fc74bb3ecf6a010f17e3a1b9eece8de4d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e0ed7f349c3b524ec796e5f7e567485c68685b62526498ac1df1f14a114047928fa54a0b428606dcf14307fe53181e9de13eb3d521f6abff0e4470635a0893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df9b0b92bc8f7301b41f0ad741d9010f80edf52254963b7f1363b47cdf3c07f2ea545a711bf9f37fe06571b081ce4a8835fc200aed050ec257dc5a3c32fbd489"} 09:24:02 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:02 INFO - Copying logs to upload dir... 09:24:02 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.606559 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-18 09:24:01.331530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 09:24:01.335586) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8497271877ac797048e48c1d5f4e9d51021b47a6abb10053c05e4dba85f5bce58e0c12f54d352ada52c5028af4e51fc74bb3ecf6a010f17e3a1b9eece8de4d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e0ed7f349c3b524ec796e5f7e567485c68685b62526498ac1df1f14a114047928fa54a0b428606dcf14307fe53181e9de13eb3d521f6abff0e4470635a0893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df9b0b92bc8f7301b41f0ad741d9010f80edf52254963b7f1363b47cdf3c07f2ea545a711bf9f37fe06571b081ce4a8835fc200aed050ec257dc5a3c32fbd489"} build_url:https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/ZJurqAeQTw6du6cQc4Qgfw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8497271877ac797048e48c1d5f4e9d51021b47a6abb10053c05e4dba85f5bce58e0c12f54d352ada52c5028af4e51fc74bb3ecf6a010f17e3a1b9eece8de4d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e0ed7f349c3b524ec796e5f7e567485c68685b62526498ac1df1f14a114047928fa54a0b428606dcf14307fe53181e9de13eb3d521f6abff0e4470635a0893", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df9b0b92bc8f7301b41f0ad741d9010f80edf52254963b7f1363b47cdf3c07f2ea545a711bf9f37fe06571b081ce4a8835fc200aed050ec257dc5a3c32fbd489"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 09:24:01.360723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:24:01.361106) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1479488416.75676-533941622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 09:24:01.444974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 09:24:01.445316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 09:24:01.445611) ========= ========= Total master_lag: 0.17 =========