builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1476789629.71 results: success (0) buildid: 20161018014548 builduid: a510ff49493d41bc90ecb890818b21e9 revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.713192) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.713645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.713925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.729236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.729586) ========= 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=523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 04:20:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-10-18 04:20:30 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.859907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.860249) ========= 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=523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.910156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:29.910518) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc89484d4b45abf442162e5ea2dd46f9de40197d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dc89484d4b45abf442162e5ea2dd46f9de40197d --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=523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 04:20:30,458 truncating revision to first 12 chars 2016-10-18 04:20:30,458 Setting DEBUG logging. 2016-10-18 04:20:30,459 attempt 1/10 2016-10-18 04:20:30,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc89484d4b45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 04:20:31,084 unpacking tar archive at: fx-team-dc89484d4b45/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:30.890027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:30.890392) ========= script_repo_revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:30.890809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:30.891085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:20:30.901342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-18 04:20:30.901807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:31 INFO - MultiFileLogger online at 20161018 04:20:31 in /builds/slave/test 04:20:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:20:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:31 INFO - {'append_to_log': False, 04:20:31 INFO - 'base_work_dir': '/builds/slave/test', 04:20:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:20:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:31 INFO - 'branch': 'Fx-Team-Non-PGO', 04:20:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:31 INFO - 'config_files': ('talos/linux_config.py',), 04:20:31 INFO - 'default_actions': ('clobber', 04:20:31 INFO - 'read-buildbot-config', 04:20:31 INFO - 'download-and-extract', 04:20:31 INFO - 'populate-webroot', 04:20:31 INFO - 'create-virtualenv', 04:20:31 INFO - 'install', 04:20:31 INFO - 'run-tests'), 04:20:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:31 INFO - 'download_minidump_stackwalk': True, 04:20:31 INFO - 'download_symbols': 'ondemand', 04:20:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:31 INFO - 'installer_path': 'installer.exe', 04:20:31 INFO - 'log_level': 'info', 04:20:31 INFO - 'log_name': 'talos', 04:20:31 INFO - 'log_to_console': True, 04:20:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:31 INFO - 'opt_config_files': (), 04:20:31 INFO - 'pip_index': False, 04:20:31 INFO - 'sps_profile': False, 04:20:31 INFO - 'sps_profile_interval': 0, 04:20:31 INFO - 'suite': 'dromaeojs', 04:20:31 INFO - 'system_bits': '32', 04:20:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:31 INFO - 'title': 'talos-linux64-ix-065', 04:20:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:31 INFO - 'use_talos_json': True, 04:20:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:31 INFO - 'work_dir': 'build'} 04:20:31 INFO - [mozharness: 2016-10-18 11:20:31.544335Z] Running clobber step. 04:20:31 INFO - Running pre-action listener: _resource_record_pre_action 04:20:31 INFO - Running main action method: clobber 04:20:31 INFO - rmtree: /builds/slave/test/build 04:20:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:32 INFO - Running post-action listener: _resource_record_post_action 04:20:32 INFO - [mozharness: 2016-10-18 11:20:32.521925Z] Finished clobber step (success) 04:20:32 INFO - [mozharness: 2016-10-18 11:20:32.522023Z] Running read-buildbot-config step. 04:20:32 INFO - Running pre-action listener: _resource_record_pre_action 04:20:32 INFO - Running main action method: read_buildbot_config 04:20:32 INFO - Using buildbot properties: 04:20:32 INFO - { 04:20:32 INFO - "project": "", 04:20:32 INFO - "product": "firefox", 04:20:32 INFO - "script_repo_revision": "production", 04:20:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:20:32 INFO - "repository": "", 04:20:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:20:32 INFO - "buildid": "20161018014548", 04:20:32 INFO - "pgo_build": "False", 04:20:32 INFO - "basedir": "/builds/slave/test", 04:20:32 INFO - "buildnumber": 2205, 04:20:32 INFO - "slavename": "talos-linux64-ix-065", 04:20:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:20:32 INFO - "platform": "ubuntu64_hw", 04:20:32 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 04:20:32 INFO - "branch": "fx-team", 04:20:32 INFO - "repo_path": "integration/fx-team", 04:20:32 INFO - "revision": "dc89484d4b45abf442162e5ea2dd46f9de40197d", 04:20:32 INFO - "stage_platform": "linux64", 04:20:32 INFO - "builduid": "a510ff49493d41bc90ecb890818b21e9", 04:20:32 INFO - "slavebuilddir": "test" 04:20:32 INFO - } 04:20:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:20:32 INFO - Running post-action listener: _resource_record_post_action 04:20:32 INFO - [mozharness: 2016-10-18 11:20:32.524439Z] Finished read-buildbot-config step (success) 04:20:32 INFO - [mozharness: 2016-10-18 11:20:32.524526Z] Running download-and-extract step. 04:20:32 INFO - Running pre-action listener: _resource_record_pre_action 04:20:32 INFO - Running main action method: download_and_extract 04:20:32 INFO - mkdir: /builds/slave/test/build/tests 04:20:32 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')]} 04:20:32 INFO - trying https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:20:32 INFO - Downloading https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:20:33 INFO - Downloaded 1361 bytes. 04:20:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:20:33 INFO - Using the following test package requirements: 04:20:33 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:20:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'jsshell-linux-x86_64.zip'], 04:20:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:20:33 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:20:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:20:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:20:33 INFO - Fetch https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:20:33 INFO - Http code: 200 04:20:33 INFO - via: 1.1 990c804118e679d7ea0f4d3ca3cc4534.cloudfront.net (CloudFront) 04:20:33 INFO - x-amz-cf-id: AFuqivK_RXDD-wwVM8BmH3Bm4CVtLYTwn0RG42Lk7aZfA5PjFrEWIA== 04:20:33 INFO - x-amz-version-id: rLLZl353rOMNhzYkK.pd64AQMPG00IuD 04:20:33 INFO - Expected file size: 20521243 04:20:33 INFO - Obtained file size: 20521243 04:20:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:20:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:20:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:20:38 INFO - Fetch https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:20:38 INFO - Http code: 200 04:20:38 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 04:20:38 INFO - x-amz-cf-id: nvg46uEeaaufOurom2raAVFebA5WhATq7rWYbobNwm7mN0s-HABHkQ== 04:20:38 INFO - x-amz-version-id: rLLZl353rOMNhzYkK.pd64AQMPG00IuD 04:20:38 INFO - Expected file size: 20521243 04:20:38 INFO - Obtained file size: 20521243 04:20:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:20:43 INFO - Fetch https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:20:44 INFO - Http code: 200 04:20:44 INFO - via: 1.1 ff09df097f823b2834408d17e9779d62.cloudfront.net (CloudFront) 04:20:44 INFO - x-amz-cf-id: XtksfSmP1DSLCqplFI6CAJxuBVDz23lL9sPqcoXtPM0xfhiEWSYIYw== 04:20:44 INFO - x-amz-version-id: lFs.cnwolmzFrdh.0Q562h0BpsonU8hN 04:20:44 INFO - Expected file size: 14409028 04:20:44 INFO - Obtained file size: 14409028 04:20:45 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')]} 04:20:45 INFO - trying https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:45 INFO - Downloading https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:20:46 INFO - Downloaded 55544595 bytes. 04:20:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:46 INFO - mkdir: /builds/slave/test/properties 04:20:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:46 INFO - Contents: 04:20:46 INFO - build_url:https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:47 INFO - Running post-action listener: _resource_record_post_action 04:20:47 INFO - Running post-action listener: set_extra_try_arguments 04:20:47 INFO - [mozharness: 2016-10-18 11:20:47.064823Z] Finished download-and-extract step (success) 04:20:47 INFO - [mozharness: 2016-10-18 11:20:47.065049Z] Running populate-webroot step. 04:20:47 INFO - Running pre-action listener: _resource_record_pre_action 04:20:47 INFO - Running main action method: populate_webroot 04:20:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:47 INFO - '--tppagecycles', 04:20:47 INFO - '7'], 04:20:47 INFO - 'tests': ['tsvgm']}}, 04:20:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['damp', 'tps']}, 04:20:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'tests': ['damp', 'tps']}, 04:20:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['dromaeo_dom']}, 04:20:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['basic_compositor_video']}, 04:20:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:20:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['a11yr', 04:20:47 INFO - 'ts_paint', 04:20:47 INFO - 'tpaint', 04:20:47 INFO - 'sessionrestore', 04:20:47 INFO - 'sessionrestore_no_auto_restore', 04:20:47 INFO - 'tabpaint']}, 04:20:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:47 INFO - 'ts_paint', 04:20:47 INFO - 'tpaint', 04:20:47 INFO - 'sessionrestore', 04:20:47 INFO - 'sessionrestore_no_auto_restore', 04:20:47 INFO - 'tabpaint']}, 04:20:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:20:47 INFO - 'ts_paint', 04:20:47 INFO - 'tpaint', 04:20:47 INFO - 'sessionrestore', 04:20:47 INFO - 'sessionrestore_no_auto_restore', 04:20:47 INFO - 'tabpaint']}, 04:20:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:20:47 INFO - 'ts_paint', 04:20:47 INFO - 'tpaint', 04:20:47 INFO - 'sessionrestore', 04:20:47 INFO - 'sessionrestore_no_auto_restore', 04:20:47 INFO - 'tabpaint']}, 04:20:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['a11yr', 04:20:47 INFO - 'ts_paint', 04:20:47 INFO - 'tpaint', 04:20:47 INFO - 'sessionrestore', 04:20:47 INFO - 'sessionrestore_no_auto_restore', 04:20:47 INFO - 'tabpaint']}, 04:20:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['a11yr', 04:20:47 INFO - 'ts_paint', 04:20:47 INFO - 'tpaint', 04:20:47 INFO - 'sessionrestore', 04:20:47 INFO - 'sessionrestore_no_auto_restore', 04:20:47 INFO - 'tabpaint']}, 04:20:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['tsvgx', 04:20:47 INFO - 'tsvgr_opacity', 04:20:47 INFO - 'tart', 04:20:47 INFO - 'tscrollx', 04:20:47 INFO - 'cart']}, 04:20:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:47 INFO - 'tsvgr_opacity', 04:20:47 INFO - 'tart', 04:20:47 INFO - 'tscrollx', 04:20:47 INFO - 'cart']}, 04:20:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'talos_options': ['--disable-e10s'], 04:20:47 INFO - 'tests': ['tp5o']}, 04:20:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'tests': ['tp5o']}, 04:20:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'talos_options': ['--disable-e10s', 04:20:47 INFO - '--xperf_path', 04:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:47 INFO - 'tests': ['tp5n']}, 04:20:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:47 INFO - 'talos_options': ['--xperf_path', 04:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:47 INFO - 'tests': ['tp5n']}}, 04:20:47 INFO - 'talos.zip': {'path': '', 04:20:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:47 INFO - Running post-action listener: _resource_record_post_action 04:20:47 INFO - [mozharness: 2016-10-18 11:20:47.082776Z] Finished populate-webroot step (success) 04:20:47 INFO - [mozharness: 2016-10-18 11:20:47.082862Z] Running create-virtualenv step. 04:20:47 INFO - Running pre-action listener: _resource_record_pre_action 04:20:47 INFO - Running main action method: create_virtualenv 04:20:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:20:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:47 INFO - Using real prefix '/usr' 04:20:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:49 INFO - Installing pip.................done. 04:20:49 INFO - Return code: 0 04:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:20:49 INFO - Reading from file tmpfile_stdout 04:20:49 INFO - Output received: 04:20:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:20:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:49 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 04:20:49 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 04:20:49 INFO - Using env: {'DISPLAY': ':0', 04:20:49 INFO - 'HOME': '/home/cltbld', 04:20:49 INFO - 'LANG': 'en_US.UTF-8', 04:20:49 INFO - 'LANGUAGE': 'en_US:en', 04:20:49 INFO - 'LOGNAME': 'cltbld', 04:20:49 INFO - 'MAIL': '/var/mail/cltbld', 04:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:49 INFO - 'MOZ_NO_REMOTE': '1', 04:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:49 INFO - 'NO_EM_RESTART': '1', 04:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:49 INFO - 'PWD': '/builds/slave/test', 04:20:49 INFO - 'SHELL': '/bin/bash', 04:20:49 INFO - 'SHLVL': '1', 04:20:49 INFO - 'TERM': 'linux', 04:20:49 INFO - 'TMOUT': '86400', 04:20:49 INFO - 'USER': 'cltbld', 04:20:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:49 INFO - '_': '/tools/buildbot/bin/python'} 04:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:20:50 INFO - Cleaning up... 04:20:50 INFO - Return code: 0 04:20:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20:50 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')]} 04:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:50 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')]} 04:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:50 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 04:20:50 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 04:20:50 INFO - Using env: {'DISPLAY': ':0', 04:20:50 INFO - 'HOME': '/home/cltbld', 04:20:50 INFO - 'LANG': 'en_US.UTF-8', 04:20:50 INFO - 'LANGUAGE': 'en_US:en', 04:20:50 INFO - 'LOGNAME': 'cltbld', 04:20:50 INFO - 'MAIL': '/var/mail/cltbld', 04:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:50 INFO - 'MOZ_NO_REMOTE': '1', 04:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:50 INFO - 'NO_EM_RESTART': '1', 04:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:50 INFO - 'PWD': '/builds/slave/test', 04:20:50 INFO - 'SHELL': '/bin/bash', 04:20:50 INFO - 'SHLVL': '1', 04:20:50 INFO - 'TERM': 'linux', 04:20:50 INFO - 'TMOUT': '86400', 04:20:50 INFO - 'USER': 'cltbld', 04:20:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:50 INFO - '_': '/tools/buildbot/bin/python'} 04:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:50 INFO - Downloading/unpacking psutil>=3.1.1 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:52 INFO - Installing collected packages: psutil 04:20:52 INFO - Running setup.py install for psutil 04:20:52 INFO - building 'psutil._psutil_linux' extension 04:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:20:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:20:52 INFO - building 'psutil._psutil_posix' extension 04:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:20:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:52 INFO - Successfully installed psutil 04:20:52 INFO - Cleaning up... 04:20:52 INFO - Return code: 0 04:20:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:52 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')]} 04:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:52 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')]} 04:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:52 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 04:20:52 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 04:20:52 INFO - Using env: {'DISPLAY': ':0', 04:20:52 INFO - 'HOME': '/home/cltbld', 04:20:52 INFO - 'LANG': 'en_US.UTF-8', 04:20:52 INFO - 'LANGUAGE': 'en_US:en', 04:20:52 INFO - 'LOGNAME': 'cltbld', 04:20:52 INFO - 'MAIL': '/var/mail/cltbld', 04:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:52 INFO - 'MOZ_NO_REMOTE': '1', 04:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:52 INFO - 'NO_EM_RESTART': '1', 04:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:52 INFO - 'PWD': '/builds/slave/test', 04:20:52 INFO - 'SHELL': '/bin/bash', 04:20:52 INFO - 'SHLVL': '1', 04:20:52 INFO - 'TERM': 'linux', 04:20:52 INFO - 'TMOUT': '86400', 04:20:52 INFO - 'USER': 'cltbld', 04:20:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:52 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:53 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 04:20:53 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 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:55 INFO - Installing collected packages: mozsystemmonitor 04:20:55 INFO - Running setup.py install for mozsystemmonitor 04:20:55 INFO - Successfully installed mozsystemmonitor 04:20:55 INFO - Cleaning up... 04:20:55 INFO - Return code: 0 04:20:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:55 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')]} 04:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:55 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')]} 04:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:55 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 04:20:55 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 04:20:55 INFO - Using env: {'DISPLAY': ':0', 04:20:55 INFO - 'HOME': '/home/cltbld', 04:20:55 INFO - 'LANG': 'en_US.UTF-8', 04:20:55 INFO - 'LANGUAGE': 'en_US:en', 04:20:55 INFO - 'LOGNAME': 'cltbld', 04:20:55 INFO - 'MAIL': '/var/mail/cltbld', 04:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:55 INFO - 'MOZ_NO_REMOTE': '1', 04:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:55 INFO - 'NO_EM_RESTART': '1', 04:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:55 INFO - 'PWD': '/builds/slave/test', 04:20:55 INFO - 'SHELL': '/bin/bash', 04:20:55 INFO - 'SHLVL': '1', 04:20:55 INFO - 'TERM': 'linux', 04:20:55 INFO - 'TMOUT': '86400', 04:20:55 INFO - 'USER': 'cltbld', 04:20:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:55 INFO - '_': '/tools/buildbot/bin/python'} 04:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:55 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 04:20:55 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 04:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 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 04:20:57 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 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:57 INFO - warning: no files found matching '*.txt' 04:20:57 INFO - no previously-included directories found matching 'build' 04:20:57 INFO - no previously-included directories found matching 'dist' 04:20:57 INFO - no previously-included directories found matching '.git*' 04:20:57 INFO - Installing collected packages: jsonschema, functools32 04:20:57 INFO - Running setup.py install for functools32 04:20:57 INFO - warning: no files found matching '*.txt' 04:20:57 INFO - no previously-included directories found matching 'build' 04:20:57 INFO - no previously-included directories found matching 'dist' 04:20:57 INFO - no previously-included directories found matching '.git*' 04:20:57 INFO - Successfully installed jsonschema functools32 04:20:57 INFO - Cleaning up... 04:20:57 INFO - Return code: 0 04:20:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:20:57 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')]} 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:57 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')]} 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:57 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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:57 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 04:20:57 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 04:20:57 INFO - Using env: {'DISPLAY': ':0', 04:20:57 INFO - 'HOME': '/home/cltbld', 04:20:57 INFO - 'LANG': 'en_US.UTF-8', 04:20:57 INFO - 'LANGUAGE': 'en_US:en', 04:20:57 INFO - 'LOGNAME': 'cltbld', 04:20:57 INFO - 'MAIL': '/var/mail/cltbld', 04:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:57 INFO - 'MOZ_NO_REMOTE': '1', 04:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:57 INFO - 'NO_EM_RESTART': '1', 04:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:57 INFO - 'PWD': '/builds/slave/test', 04:20:57 INFO - 'SHELL': '/bin/bash', 04:20:57 INFO - 'SHLVL': '1', 04:20:57 INFO - 'TERM': 'linux', 04:20:57 INFO - 'TMOUT': '86400', 04:20:57 INFO - 'USER': 'cltbld', 04:20:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:57 INFO - '_': '/tools/buildbot/bin/python'} 04:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:20:58 INFO - Cleaning up... 04:20:58 INFO - Return code: 0 04:20:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:58 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')]} 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:58 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')]} 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:58 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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:58 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 04:20:58 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 04:20:58 INFO - Using env: {'DISPLAY': ':0', 04:20:58 INFO - 'HOME': '/home/cltbld', 04:20:58 INFO - 'LANG': 'en_US.UTF-8', 04:20:58 INFO - 'LANGUAGE': 'en_US:en', 04:20:58 INFO - 'LOGNAME': 'cltbld', 04:20:58 INFO - 'MAIL': '/var/mail/cltbld', 04:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:58 INFO - 'MOZ_NO_REMOTE': '1', 04:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:58 INFO - 'NO_EM_RESTART': '1', 04:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:58 INFO - 'PWD': '/builds/slave/test', 04:20:58 INFO - 'SHELL': '/bin/bash', 04:20:58 INFO - 'SHLVL': '1', 04:20:58 INFO - 'TERM': 'linux', 04:20:58 INFO - 'TMOUT': '86400', 04:20:58 INFO - 'USER': 'cltbld', 04:20:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:58 INFO - '_': '/tools/buildbot/bin/python'} 04:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:58 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 04:20:58 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 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 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 04:21:00 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 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 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 04:21:00 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 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 INFO - Downloading docopt-0.6.1.tar.gz 04:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:00 INFO - Running setup.py install for blobuploader 04:21:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:01 INFO - Running setup.py install for requests 04:21:01 INFO - Running setup.py install for docopt 04:21:01 INFO - Successfully installed blobuploader requests docopt 04:21:01 INFO - Cleaning up... 04:21:01 INFO - Return code: 0 04:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:01 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')]} 04:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:01 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')]} 04:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:01 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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:01 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 04:21:01 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 04:21:01 INFO - Using env: {'DISPLAY': ':0', 04:21:01 INFO - 'HOME': '/home/cltbld', 04:21:01 INFO - 'LANG': 'en_US.UTF-8', 04:21:01 INFO - 'LANGUAGE': 'en_US:en', 04:21:01 INFO - 'LOGNAME': 'cltbld', 04:21:01 INFO - 'MAIL': '/var/mail/cltbld', 04:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:01 INFO - 'MOZ_NO_REMOTE': '1', 04:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:01 INFO - 'NO_EM_RESTART': '1', 04:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:01 INFO - 'PWD': '/builds/slave/test', 04:21:01 INFO - 'SHELL': '/bin/bash', 04:21:01 INFO - 'SHLVL': '1', 04:21:01 INFO - 'TERM': 'linux', 04:21:01 INFO - 'TMOUT': '86400', 04:21:01 INFO - 'USER': 'cltbld', 04:21:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:01 INFO - '_': '/tools/buildbot/bin/python'} 04:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:01 INFO - Running setup.py (path:/tmp/pip-V2DB8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:01 INFO - Running setup.py (path:/tmp/pip-RafIBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:01 INFO - Running setup.py (path:/tmp/pip-eB_fP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:02 INFO - Running setup.py (path:/tmp/pip-TyuK6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:02 INFO - Running setup.py (path:/tmp/pip-V_8YUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:02 INFO - Running setup.py (path:/tmp/pip-Xlvb2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:02 INFO - Running setup.py (path:/tmp/pip-unxhLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:02 INFO - Running setup.py (path:/tmp/pip-tYFDhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:02 INFO - Running setup.py (path:/tmp/pip-Qfir05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:02 INFO - Running setup.py (path:/tmp/pip-hZ5HIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:02 INFO - Running setup.py (path:/tmp/pip-4hPhed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:02 INFO - Running setup.py (path:/tmp/pip-lwYRC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:02 INFO - Running setup.py (path:/tmp/pip-XKnhzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:02 INFO - Running setup.py (path:/tmp/pip-um5OdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:02 INFO - Running setup.py (path:/tmp/pip-ihobtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:02 INFO - Running setup.py (path:/tmp/pip-n4KBMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:02 INFO - Running setup.py (path:/tmp/pip-E2o56o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:03 INFO - Running setup.py install for manifestparser 04:21:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozcrash 04:21:03 INFO - Running setup.py install for mozdebug 04:21:03 INFO - Running setup.py install for mozdevice 04:21:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozfile 04:21:03 INFO - Running setup.py install for mozhttpd 04:21:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozinfo 04:21:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozInstall 04:21:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:03 INFO - Running setup.py install for mozleak 04:21:03 INFO - Running setup.py install for mozlog 04:21:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for moznetwork 04:21:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for mozprocess 04:21:04 INFO - Running setup.py install for mozprofile 04:21:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for mozrunner 04:21:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Running setup.py install for mozscreenshot 04:21:04 INFO - Running setup.py install for moztest 04:21:04 INFO - Running setup.py install for mozversion 04:21:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:04 INFO - Cleaning up... 04:21:04 INFO - Return code: 0 04:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:04 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')]} 04:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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')]} 04:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:04 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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:04 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 04:21:04 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 04:21:04 INFO - Using env: {'DISPLAY': ':0', 04:21:04 INFO - 'HOME': '/home/cltbld', 04:21:04 INFO - 'LANG': 'en_US.UTF-8', 04:21:04 INFO - 'LANGUAGE': 'en_US:en', 04:21:04 INFO - 'LOGNAME': 'cltbld', 04:21:04 INFO - 'MAIL': '/var/mail/cltbld', 04:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:04 INFO - 'MOZ_NO_REMOTE': '1', 04:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:04 INFO - 'NO_EM_RESTART': '1', 04:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:04 INFO - 'PWD': '/builds/slave/test', 04:21:04 INFO - 'SHELL': '/bin/bash', 04:21:04 INFO - 'SHLVL': '1', 04:21:04 INFO - 'TERM': 'linux', 04:21:04 INFO - 'TMOUT': '86400', 04:21:04 INFO - 'USER': 'cltbld', 04:21:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:04 INFO - '_': '/tools/buildbot/bin/python'} 04:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:05 INFO - Running setup.py (path:/tmp/pip-MtCJDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:05 INFO - Running setup.py (path:/tmp/pip-sBFmnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:05 INFO - Running setup.py (path:/tmp/pip-VqqubN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:05 INFO - Running setup.py (path:/tmp/pip-zQVui3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:05 INFO - Running setup.py (path:/tmp/pip-NWS_GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:05 INFO - Running setup.py (path:/tmp/pip-DpHinz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:05 INFO - Running setup.py (path:/tmp/pip-EEie7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:05 INFO - Running setup.py (path:/tmp/pip-fWl2c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:05 INFO - Running setup.py (path:/tmp/pip-LYr9OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:05 INFO - Running setup.py (path:/tmp/pip-SH7age-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:05 INFO - Running setup.py (path:/tmp/pip-iKqckK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:05 INFO - Running setup.py (path:/tmp/pip-WuZ8UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:05 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)) 04:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:05 INFO - Running setup.py (path:/tmp/pip-Njg1ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:06 INFO - Running setup.py (path:/tmp/pip-tRu0AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:06 INFO - Running setup.py (path:/tmp/pip-u14VpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:06 INFO - Running setup.py (path:/tmp/pip-2WZ30Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:06 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)) 04:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:06 INFO - Running setup.py (path:/tmp/pip-bJOKax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:21:06 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)) 04:21:06 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)) 04:21:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:06 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 04:21:06 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 04:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:08 INFO - Downloading blessings-1.6.tar.gz 04:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:08 INFO - Installing collected packages: blessings 04:21:08 INFO - Running setup.py install for blessings 04:21:08 INFO - Successfully installed blessings 04:21:08 INFO - Cleaning up... 04:21:08 INFO - Return code: 0 04:21:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:08 INFO - Reading from file tmpfile_stdout 04:21:08 INFO - Current package versions: 04:21:08 INFO - argparse == 1.2.1 04:21:08 INFO - blessings == 1.6 04:21:08 INFO - blobuploader == 1.2.4 04:21:08 INFO - docopt == 0.6.1 04:21:08 INFO - functools32 == 3.2.3-2 04:21:08 INFO - jsonschema == 2.5.1 04:21:08 INFO - manifestparser == 1.1 04:21:08 INFO - mozInstall == 1.12 04:21:08 INFO - mozcrash == 0.17 04:21:08 INFO - mozdebug == 0.1 04:21:08 INFO - mozdevice == 0.48 04:21:08 INFO - mozfile == 1.2 04:21:08 INFO - mozhttpd == 0.7 04:21:08 INFO - mozinfo == 0.9 04:21:08 INFO - mozleak == 0.1 04:21:08 INFO - mozlog == 3.4 04:21:08 INFO - moznetwork == 0.27 04:21:08 INFO - mozprocess == 0.23 04:21:08 INFO - mozprofile == 0.28 04:21:08 INFO - mozrunner == 6.12 04:21:08 INFO - mozscreenshot == 0.1 04:21:08 INFO - mozsystemmonitor == 0.3 04:21:08 INFO - moztest == 0.7 04:21:08 INFO - mozversion == 1.4 04:21:08 INFO - psutil == 3.1.1 04:21:08 INFO - requests == 1.2.3 04:21:08 INFO - wsgiref == 0.1.2 04:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:08 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')]} 04:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 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')]} 04:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:08 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 04:21:08 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 04:21:08 INFO - Using env: {'DISPLAY': ':0', 04:21:08 INFO - 'HOME': '/home/cltbld', 04:21:08 INFO - 'LANG': 'en_US.UTF-8', 04:21:08 INFO - 'LANGUAGE': 'en_US:en', 04:21:08 INFO - 'LOGNAME': 'cltbld', 04:21:08 INFO - 'MAIL': '/var/mail/cltbld', 04:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:08 INFO - 'MOZ_NO_REMOTE': '1', 04:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:08 INFO - 'NO_EM_RESTART': '1', 04:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:08 INFO - 'PWD': '/builds/slave/test', 04:21:08 INFO - 'SHELL': '/bin/bash', 04:21:08 INFO - 'SHLVL': '1', 04:21:08 INFO - 'TERM': 'linux', 04:21:08 INFO - 'TMOUT': '86400', 04:21:08 INFO - 'USER': 'cltbld', 04:21:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:08 INFO - '_': '/tools/buildbot/bin/python'} 04:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:21:08 INFO - Cleaning up... 04:21:08 INFO - Return code: 0 04:21:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:08 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')]} 04:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 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')]} 04:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:08 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 0x7f48919fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:08 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 04:21:08 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 04:21:08 INFO - Using env: {'DISPLAY': ':0', 04:21:08 INFO - 'HOME': '/home/cltbld', 04:21:08 INFO - 'LANG': 'en_US.UTF-8', 04:21:08 INFO - 'LANGUAGE': 'en_US:en', 04:21:08 INFO - 'LOGNAME': 'cltbld', 04:21:08 INFO - 'MAIL': '/var/mail/cltbld', 04:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:08 INFO - 'MOZ_NO_REMOTE': '1', 04:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:08 INFO - 'NO_EM_RESTART': '1', 04:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:08 INFO - 'PWD': '/builds/slave/test', 04:21:08 INFO - 'SHELL': '/bin/bash', 04:21:08 INFO - 'SHLVL': '1', 04:21:08 INFO - 'TERM': 'linux', 04:21:08 INFO - 'TMOUT': '86400', 04:21:08 INFO - 'USER': 'cltbld', 04:21:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:08 INFO - '_': '/tools/buildbot/bin/python'} 04:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:09 INFO - Cleaning up... 04:21:09 INFO - Return code: 0 04:21:09 INFO - Running post-action listener: _resource_record_post_action 04:21:09 INFO - Running post-action listener: _start_resource_monitoring 04:21:09 INFO - Starting resource monitoring. 04:21:09 INFO - [mozharness: 2016-10-18 11:21:09.193164Z] Finished create-virtualenv step (success) 04:21:09 INFO - [mozharness: 2016-10-18 11:21:09.193674Z] Running install step. 04:21:09 INFO - Running pre-action listener: _resource_record_pre_action 04:21:09 INFO - Running main action method: install 04:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:09 INFO - Reading from file tmpfile_stdout 04:21:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:09 INFO - Reading from file tmpfile_stdout 04:21:09 INFO - Output received: 04:21:09 INFO - Usage: mozinstall [options] installer 04:21:09 INFO - Options: 04:21:09 INFO - -h, --help show this help message and exit 04:21:09 INFO - -d DEST, --destination=DEST 04:21:09 INFO - Directory to install application into. [default: 04:21:09 INFO - "/builds/slave/test"] 04:21:09 INFO - --app=APP Application being installed. [default: firefox] 04:21:09 INFO - mkdir: /builds/slave/test/build/application 04:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:21:25 INFO - Reading from file tmpfile_stdout 04:21:25 INFO - Output received: 04:21:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:25 INFO - Running post-action listener: _resource_record_post_action 04:21:25 INFO - [mozharness: 2016-10-18 11:21:25.530319Z] Finished install step (success) 04:21:25 INFO - [mozharness: 2016-10-18 11:21:25.530561Z] Running run-tests step. 04:21:25 INFO - Running pre-action listener: _resource_record_pre_action 04:21:25 INFO - Running main action method: run_tests 04:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:25 INFO - Python 2.7.3 04:21:25 INFO - Return code: 0 04:21:25 INFO - grabbing minidump binary from tooltool 04:21:25 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')]} 04:21:25 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 0x1a5ef60>, '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 0x1a5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a601d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:21:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:21:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:21:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:25 INFO - Return code: 0 04:21:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:21:25 INFO - Using env: {'DISPLAY': ':0', 04:21:25 INFO - 'HOME': '/home/cltbld', 04:21:25 INFO - 'LANG': 'en_US.UTF-8', 04:21:25 INFO - 'LANGUAGE': 'en_US:en', 04:21:25 INFO - 'LOGNAME': 'cltbld', 04:21:25 INFO - 'MAIL': '/var/mail/cltbld', 04:21:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:25 INFO - 'MOZ_NO_REMOTE': '1', 04:21:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:25 INFO - 'NO_EM_RESTART': '1', 04:21:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:25 INFO - 'PWD': '/builds/slave/test', 04:21:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:25 INFO - 'SHELL': '/bin/bash', 04:21:25 INFO - 'SHLVL': '1', 04:21:25 INFO - 'TERM': 'linux', 04:21:25 INFO - 'TMOUT': '86400', 04:21:25 INFO - 'USER': 'cltbld', 04:21:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222', 04:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:25 INFO - '_': '/tools/buildbot/bin/python'} 04:21:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:21:25 INFO - mozversion application_buildid: 20161018014548 04:21:25 INFO - mozversion application_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 04:21:25 INFO - mozversion application_display_name: Nightly 04:21:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:25 INFO - mozversion application_name: Firefox 04:21:25 INFO - mozversion application_remotingname: firefox 04:21:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:21:25 INFO - mozversion application_vendor: Mozilla 04:21:25 INFO - mozversion application_version: 52.0a1 04:21:25 INFO - mozversion platform_buildid: 20161018014548 04:21:25 INFO - mozversion platform_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 04:21:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:21:25 INFO - mozversion platform_version: 52.0a1 04:21:25 INFO - using testdate: 1476789685 04:21:25 INFO - actual date: 1476789685 04:21:25 INFO - starting webserver on 'localhost:50343' 04:21:25 INFO - SUITE-START | Running 2 tests 04:21:25 INFO - TEST-START | dromaeo_css 04:21:25 INFO - operating with platform_type : linux_ 04:21:25 INFO - Initialising browser for dromaeo_css test... 04:21:25 INFO - TEST-INFO | started process 9813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeajrGy/profile http://localhost:50343/getInfo.html) 04:21:30 INFO - PROCESS | 9813 | __metrics Screen width/height:1600/1200 04:21:30 INFO - PROCESS | 9813 | colorDepth:24 04:21:30 INFO - PROCESS | 9813 | Browser inner width/height: 1024/697 04:21:30 INFO - PROCESS | 9813 | __metrics 04:21:30 INFO - PROCESS | 9813 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:21:30 INFO - PROCESS | 9813 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:21:31 INFO - PROCESS | 9813 | console.error: PushService: 04:21:31 INFO - PROCESS | 9813 | stateChangeProcessEnqueue: Error transitioning state 04:21:31 INFO - PROCESS | 9813 | UnknownError 04:21:32 INFO - TEST-INFO | 9813: exit 0 04:21:32 INFO - Browser initialized. 04:21:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:32 INFO - TEST-INFO | started process 9894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeajrGy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:44 INFO - PROCESS | 9894 | RSS: Main: 173846528 04:21:44 INFO - PROCESS | 9894 | 04:22:35 INFO - PROCESS | 9894 | 1476789755977 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] 04:24:50 INFO - PROCESS | 9894 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50343/tests/dromaeo/cssquery-ext.html) 04:24:51 INFO - PROCESS | 9894 | RSS: Main: 302317568 04:24:51 INFO - PROCESS | 9894 | 04:27:54 INFO - PROCESS | 9894 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-ext.html (next: http://localhost:50343/tests/dromaeo/cssquery-jquery.html) 04:27:54 INFO - PROCESS | 9894 | RSS: Main: 281210880 04:27:54 INFO - PROCESS | 9894 | 04:30:56 INFO - PROCESS | 9894 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50343/tests/dromaeo/cssquery-mootools.html) 04:30:57 INFO - PROCESS | 9894 | RSS: Main: 278839296 04:30:57 INFO - PROCESS | 9894 | 04:33:59 INFO - PROCESS | 9894 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50343/tests/dromaeo/cssquery-prototype.html) 04:34:00 INFO - PROCESS | 9894 | RSS: Main: 221704192 04:34:00 INFO - PROCESS | 9894 | 04:37:03 INFO - PROCESS | 9894 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50343/tests/dromaeo/cssquery-yui.html) 04:37:03 INFO - PROCESS | 9894 | RSS: Main: 222781440 04:37:03 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-yui.html (next: http://localhost:50343/tests/dromaeo/cssquery-dojo.html) 04:40:07 INFO - PROCESS | 9894 | RSS: Main: 312860672 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | __start_tp_report 04:40:07 INFO - PROCESS | 9894 | _x_x_mozilla_page_load 04:40:07 INFO - PROCESS | 9894 | _x_x_mozilla_page_load_details 04:40:07 INFO - PROCESS | 9894 | |i|pagename|runs| 04:40:07 INFO - PROCESS | 9894 | |0;dojo.html;2606.0618177456113;2618.5810270356747;2643.8678066096695;2661.4144888124606;2673.933151671208;4643.7910294036765;4726.409198850144;4802.783874725637;4822.903541929164;4832.347633069535;4766.904661906759;4768.690035147713;4774.976125119379;4778.378810754606;4778.4743678195455;4362.0839623678985;4378.080603073358;4401.185780630578;4419.270820314644;4426.15902978433;4384.101259241847;4391.033972526056;4411.691181617288;4415.558444155575;4429.468463784334;4375.38744575758;4378.1681480518755;4391;4425.203463376591;4455.309427038798;4451.399061126739;4459.175052615276;4464.55354464551;4474.731516109011;4494.37078808967;4290.592393722592;4327.805248763813;4340.175366680321;4372.2130016597;4427.158839820456;4707.246840505537;4745;4746.644001699887;4774.259989701602;4776.832810851603;5050.242463630448;5076.466970968032;5108.157154069574;5136.717480538568;5147.4080480744815;4980.2778597103215;5031.018951304461;5036.546710796009;5148.9959457905725;5169.302144210521;4743.217369134123;4776.259679749644;4781.378420805273;4789.353437285922;4851.078295123915;5229.006488767122;5233.659812112201;5239.947600524022;5244.842654720364;5298.97350513245;4910.705357678551;5011.574016208663;5018.799248030111;5025.748712564357;5030.8239211627415;5032.899342013139;5089.541941225308;5104.897902041938;5113.846584602394;5125.974370128126;5091.439941606421;5093.974530127326;5099.388073431212;5141.408737995179;5170.353705786777;5063.8987220255385;5077.822276220315;5088.0587091388215;5088.287639730441;5150.150225212873;4271.594198551133;4309.6767742418815;4317.654587632982;4325.070109926381;4328.329108988112;3774.471573979645;3785.432185172246;3840.558335791364;3842.9807850960565;3854.1520865409566;4304.182205380967;4339.5660433956355;4340.804663790137;4343.609075183249;4400.141972315432;4957.529034741694;4974.129527332702;4974.353334066621;5088.313077734459;5100.336956195671;4234.830606775756;4252.893677658083;4253.000544871953;4259.893502662459;4264.978675106605;4498.235299999008;4526.253168227271;4539.568740969603;4589.242774942164;4617.3304870793545;4824.131656301759;4875.902481950412;4879.365682461257;4881.072596206852;4886.340344053508;5128.948710512847;5129.538341549279;5132.7177005263575;5145.897082058413;5206.453322401245;4656.534346565317;4774.95225047759;4830.589399901048;4835.298881662069;4841.515848415131;4990.451050384528;5035.446100928822;5063.721495317793;5081.517255860687;5144.228365745168;5126.384833819965;5156.20078887773;5172.353455818023;5172.922406163835;5175.534201921694;5022.84931452057;5023;5023.2716256143385;5024.773885175249;5080.618953578571;4874.7562621868055;4930.482299358516;4930.827421040246;4962.5533701967;5005.974970125126;4955.380577427822;4961.925571116364;4962.975185124052;5007.599392048554;5022.1964485683575;5053;5059.139946209079;5060.3927528696795;5065.8733531662;5123.538881500683;4779.498152693917;4834.347363106076;4852.199387101089;4945.4807245238735;4945.646753764921 04:40:07 INFO - PROCESS | 9894 | |1;ext.html;559.7956745787784;560.277242357359;565.9773609055638;579.9271348006189;582.9768755833513;28227.576586351195;28847.134585962427;39146.217075658504;39620.80189599055;39925;39283.410748838716;39747.602523974754;39804.601953980455;39838.20323593527;39846;7624.161342252348;7773.416993725465;7783.4162437817395;7783.76648700537;7786.961065194666;7518.962405187994;7606.125295591022;7608.961955190216;7609.467337286392;7613.0483689538805;7598.506097103671;7636.4654474186555;7644.923550764477;7646.770596882103;7648.808779780495;7583.393328533704;7604.54372737632;7617.047869016373;7618.542887426772;7623.771286861375;7385.519941203858;7441.665125069385;7442.627868606548;7443.59060251686;7444.516106453063;37325.44011839825;37767.05582360436;37778;37781.24437511234;37919.43120853162;3018.44158830617;3198.504231844068;3573.1424458130123;3591.8204089795404;3643.653852883972;27035.1889443317;27591.724082759116;27765.861170694017;29528;29759.404811903856;3107.4717298059386;3142.6700196479496;3145.968540314613;3185.792923459968;3189.282411457427;241042;241456;242043;242692;243501;52598.737006314725;52937.735311323195;52995.73502132465;52996.6404031511;53121.46878531243;31785.841070794497;32264.516032259537;32297.192570185933;34010.48984265238;55405.72297138489;13740.519081832288;13877.583672489842;13881.305934703225;13899.513517027057;13900.791488127687;10398.376097434028;10464;10482.371057736407;10483.161347092215;10487.790244195074;17125.400610978555;17189.656206875792;17226.741598876026;17260.654786904444;17270.064089104882;6793.422559082434;6795.422389096883;6911.17065952089;6917.792466226021;7013.92986070143;751.5678484871221;759.9240075992467;845.4969293270494;899.532243233528;984.1978787288338;25615.743842561707;26735.121687720282;26814.195574132806;27249.455010900067;27367.72632273652;769.1270408086862;898.4025622960788;924.5793164110314;939.2532936315646;975.5171190260867;13344.332783360793;13770.724585508233;14396.064255823547;14459;14477.493287734878;343678;351332;351753;352617;353181;47826.76086619614;48203.276950845764;48255.27617085746;48325.75837120792;48329;1073.2433634287809;1086.0334302470808;1091.0507858163448;1167.550493060161;1178.4814681540095;26339.736602634493;28408.57387139153;30995.69004309928;31872.203194920312;31920.201994950312;51008.48991510186;53016.73491632517;53064.93870122653;53078.73460632672;53152.4684753163;319134;320062;320434;321017;321859;24820.25539233826;25051.624225636264;25195.74804251934;37198.62801371951;37638.2472350546;41060.79469602633;41494;41521.584784151775;41561.792191038854;41744;34719.4792078114;34738.47892281567;34848;34918.65081349154;35015.299694005465;34219.315613688086;34472.655273446944;34797.652023480456;34949.65050349464;35105.82447087748;29888;30470.085897422225;33233.66766332306;33359.66640333566;33519.32961340808;30478;31798.523022154222;32333.838330808194;32345.838270809436;32778.83610581932;24173.395665108514;24242.15152469655;24339.756602434456;24502.387440314134;24880.87559562263 04:40:07 INFO - PROCESS | 9894 | |2;jquery.html;342.3956716395561;355.6248158193106;356.2820915854552;360.4701089398584;382.4626399908128;15060.246987650615;15342.23288835558;16431;16590.50228493144;16747.4138405156;15730.292136853841;15782.684346313066;16034.278457469412;16223.918880405581;16259.51221463355;4731.597814185799;4990.351254336932;5109.923351149736;5135.152699804527;5138.897222055557;4967.180415231501;5075.695458272497;5076.873078173038;5080.263361812554;5082.440931497532;4998.875028124307;6403.167588213549;6696.8995465068065;6724.159480064992;6724.394804467622;6662.333766623347;6768.966155169217;6809.795706128799;6812.62530560819;6898.379145876896;6655.401013908723;6677.732890684367;6711.865762684768;6715.764948226837;6721.731130754764;20886.791132088638;21989.340319790434;22220.888895555418;22351.217707380325;22620.773792262196;1933.2943475631293;2023.1300540767463;2186.5517568898495;2200.1639377036786;2631.5131700635443;13978.510752123728;14039.929800350932;14279.357428915724;14311.998160128795;15001.249937503082;1808.638272345536;1849.9075046247633;1895.9431217063373;1924.191839427444;1937.0218039889764;78992;83081.75377369404;83251.58374208151;83340.58329708374;84213;15598.844011559739;15658.946505431331;15693.921530392276;16241.106739129225;16274.186290685418;27664.861675691896;27802.3049423762;28020.159395217768;28046;28179;7881.093674227537;8097.346227091639;8131.227533384319;8337.374696897636;8811.647534098563;6402.295747467775;6458.741650333934;6574.285528676282;6753.358430949052;6949.166100068024;7765.53406795594;7953;8053.395995300376;8088.459405307383;8090.1909809018625;2993.7546839870097;3129.8122112673313;3153.805438766435;3199.6162858669973;3338.5993680758465;702.1580450650539;827.0034608296987;860.1871231686122;864.7196377929275;871.5511511571545;15117.697646047018;15325.923370383076;15899.761503577456;15985.200739963188;16402.507924762278;813.3899575318511;823.8064054947083;824.3405275779353;831.4678605692362;869.3349587565517;8195.877061844078;8317.085120636724;8529.189726975927;8761.474311541328;9131.863022054675;364163;371625;375677;376587;378554;71831.28168718246;75306.62346688341;77515.61242193753;77936.22063779403;78467;843.5950743642964;866.6966561703354;867.4491697771961;869.0614136732314;869.9173578510031;14127.788083178966;14191.929040354733;14269.42922283097;14314.928425357806;14567.927160364554;34905.47641785426;35200.11999699925;35934.92195234147;36277.818610906776;37539.24921501609;46757.766211168724;49106.424247272866;49335.75332123316;49514.75242623908;51180.74409627928;4545.59089681917;4581.450225972904;6839.418649414656;7208.387287080657;7283.781486555412;9486.905130948602;10764.979900450084;11429.59996400122;11482.425878706199;11799.115066370228;9942.403455792675;10022.498875056071;10121.139703125316;10183.490825458846;10410.583576656849;9925.602975881173;10043.4476103815;10134.543945522322;10155.7461063474;10286.485675716334;9583.808323833346;9588.56851441673;9727.610895564098;9882.703518894445;9945.651902183388;7479.439042071976;7586;7684.116326622287;7691.30778229962;7712.807179820549;9220.26237900953;9506.382085164441;9697.6120955161;9776.217902567636;10023.799524009624 04:40:07 INFO - PROCESS | 9894 | |3;mootools.html;1228.8586812516564;1358.2801115408831;1398.223985687943;1462.8390877003528;1702.8978261304323;6345;6868.725250989961;6959.2692767259405;7083.220845706968;7195.208527062019;7308.378787803043;7310.135915341581;7314.524555903862;7339.449541284412;7340.412766978642;2131.3925531223645;2159.730033745782;2163.7403511578555;2164.2208804830248;2168.143583284602;2125.9893700531475;2168.620491414004;2174.967375489369;2175.564887022594;2179.1610230061383;2115.6826476028564;2118.8834614096218;2123.8106660270223;2125.362391282617;2181.7054697615777;2035.521652411682;2130.9041093150845;2133.3919832847564;2140.9357719268446;2141.9036143373587;2081.739782527184;2137.2519618133683;2145.324222869807;2153.91384344626;2156.137544982004;7447.44144189188;7465.440091993068;7477.065366829146;7486.85026299471;7498.8125296867465;4313.1804957058375;4384.12317536494;4469.888252793674;4530.909381812378;4531.252343363341;2779.8888044478194;2830.2075418882746;2926.356201635658;2936.515474946653;2939.4415061138316;857.5712143928037;863.7754183912228;876.7238319929265;884.3765145572356;901.8737376767258;9500.762480937963;9866.062724041205;10017.39895606266;10060.144887684555;10124.89875101247;3950.229705207457;4000.7799571023875;4144.772037537964;4150.709450338508;4207.368894665825;8570.271526920282;8605.827883442296;8642.481451112953;8642.95678521616;8643.438176518632;4560.521145279764;4570.794314255866;4588.26587745959;4594.19601569724;4596.517365676623;3613.5483064616924;3738.6635202831876;4045.5347635021762;4149.543550209474;4152.418661387408;3438.9828050860087;3502.0719509330047;3562.2697347043795;3600.6039335673054;3611.9277614448088;1108.14672702019;1124.3759713359163;1136.5681041204289;1142.5943789954613;1156.8380426740096;766.6856588798565;781.9257170568901;814.4095530740284;843.0599881132493;843.3716880923629;4839.153148199051;4969.428515720666;5059.620528460307;5103.362079740033;5142.125838607446;785.7249962513075;786.6735304848538;797.3621103117483;879.7316818370331;883.1212943121635;3418.9829050854587;3480.7563470557325;3557.0573797943566;3577.7853328800356;3607.1703508193264;9193.586288617029;9446.574904129193;9464.526773661428;9492.098250666175;9516.619335226513;8336.916630833735;9139.451632902048;9148.222401095982;9157.358984871129;9218.216451601555;6656.8668626627195;6935.098437203132;6947.617881016593;6950.930490695129;6959.478039147084;5076.7207803571155;5195.246689230116;5273.156294992783;5354.464553544614;5377.704226267593;8007.879881801661;8070.515769053875;8237.711680091168;8243.629036693483;8262.545559994258;8129.105798362294;8406.747797566082;8515.659373625233;8526.82946341082;8588.098249683693;6112.572119951561;6295.464885484785;6374;6527.575707579183;6538.607683539003;7044.542104763379;7064.293570642894;7066.116735408074;7094.929050709633;7101.254368291255;6202.131701561695;6386.329435409215;6406.199225096863;6562.507811914221;6572.178477690289;6330.746770129143;6370.713317900613;6388.93611063902;6404.423601875854;6466.870662586816;6179.721912514037;6258.249010118815;6259.906101408392;6267.185265915402;6277.372262773686;4474.440694913136;4498.370228167993;4504.031633198747;4564.315352696989;4654.092451971968;4305.698601098018;4315.719478233905;4318.481782186032;4321.654267658517;4342.32693932441 04:40:07 INFO - PROCESS | 9894 | |4;prototype.html;292.28390443413645;292.31306429889764;297.7885701152182;307.83838484795496;308.0742369180612;4902.901941961159;4927.457979622243;4932.112219800434;4967.10592093423;5006.849794506162;4846.684965477241;4860.781264843082;4893.1436998525205;4894.730789806559;4910.165271903776;3869.303525365433;3873.3221686204943;3892.9610703892954;3907.948327128252;3911.4915061042025;3737.3646480098314;3886.1061955750192;3891.5330160380795;3896.0649444133346;3910.667593254577;3802.049487628093;3824.9808750956345;3825.61743825618;3834.2331533693373;3869.3228684980018;3775.188334508094;3800.4489349044234;3811.3520701480675;3814.5123401873293;3822.5412950445984;3084.8457577121053;3168.3188114555483;3229.919252018695;3380.459126539766;3381.8140002299865;4657.301404789275;4661.627069834405;4668.626509879202;4678.836240731592;4692.36653051837;4277.967965216529;4301.311790113598;4310.806013729359;4310.80601372939;4310.849120280806;4712.78792454337;4830.178869592178;5027.874303142414;5051;5100.438951715309;3640.12636967126;3658.835352409148;3659.505966694489;3660.7919386602357;3664.6885014773775;5293.708846013467;5305.814296499604;5306.071437498461;5310;5310.15906490026;3481.1819222482695;3619.475176099451;3744.5319335083113;3765.0963768695865;3770.2647983643474;3689.612590677994;3694.1503454205144;3695.519582454264;3704;3716.6840818530186;4221.7255878367805;4222.261104306734;4233.5131459881895;4234.513031001413;4235.661147108224;5021.221710634857;5051.747412629354;5061.721605311744;5067.138586440314;5077.365329333833;1218.561317925546;1278.4949944771763;1283.3839756916732;1297.2216669998115;1301.3493253373313;797;809.2918696140877;820.0856045509214;827.3009307135461;827.5034979012544;3952.213689349002;3971.543272523639;3971.841126354971;4010.7393019453643;4022.1754540319166;4530.841420550265;4535.546445355504;4547.930691535344;4560.4071470708595;4600.677952543289;3956.8615098471414;3960.20795840833;3970;3972.483577134954;3979.5622481527007;2324.4176691065195;2408.157759314126;2437.8668664918196;2449.5835707929696;2466.962995555068;4361.0841723237845;4672.2057250267535;4797.208460603962;4815.807367705323;4911;5309.389420216725;5344;5358.544523715528;5361.865953351197;5370.221317908881;4897.3878265216845;4919.900462708542;4922.458529561745;4923.409190897115;4941.407031156285;5069.935313584188;5157.587393008625;5205.817796377109;5227.712475813867;5237.685738855681;5134.897302053863;5137.537621614073;5162.432132465501;5170.689758614495;5176.559992400688;4690.366800481891;4916.508349165055;4916.803327866988;4920.302495638999;4945.282933974626;3637.5453068366455;3650.3170169925615;3654.8720794772057;3655.61616030313;3656.5246517952496;5224.219838847412;5236.581073514186;5238.528532432099;5243.033862301637;5249.291345668286;5094.802721360551;5106.744662766772;5128.512791284822;5145.819896303611;5156.710822294426;4853;5101.826579886572;5124.846254612367;5129.2819005340025;5150.433452320317;5028.371453568304;5030.496950305087;5040.924386134137;5055.469175736642;5068.974655126701;4972.279019542074;5177.585793136464;5179.48205179479;5183.637145399936;5200;4988.528384126764;4994.453937704271;4997.775100120576;5028.15346260104;5033.245013247895 04:40:07 INFO - PROCESS | 9894 | |5;yui.html;638.4796390941384;689.3038031588095;695.6834640238689;703.5216053083901;718.1418205244732;12151;12952.35238238089;12960.74078518429;12977.545785897495;13049.086563940527;13253.602391928234;13286.26925519096;13426.932865335684;13438.462461501553;13452.125611835223;615.572177336749;632.7026297640102;736.6280028585556;760.228368206271;766.9808254793647;747.2714103748829;765.9234076592352;767.3094215206303;767.6277005652254;774.3882332956957;825.0800357601262;827.2224109337204;827.3133299361546;827.6482494939656;827.7682248970298;649.7855707616475;667.8096742428385;819.7950512371907;819.9098099209082;820.3683163963744;575.1602660116235;590.9881802363972;591.2550186764664;591.3081694417542;595.600947365262;12469.251844889244;12470.127091103626;12474.563390281388;12485.56300529477;12491.437885295183;11306.491207895582;12122.757544849053;12148.45331960064;12176.147669663127;12951.222926624338;11473.942630286878;11682.29906205622;11725.355105469196;11791.941040294829;12239.143259971806;3945.9802700986597;3958.5447673517624;4007.6393124618926;4106.404571337169;4150.688698347636;61521.69239153821;63159.05261421082;63658.363416365704;64166.3583364165;64241.35758642447;9732.90267097334;9754.804903901882;9864.950675246579;9902.306838521234;10086.445245511568;19118.044097795333;19119.52201194981;19143.904280478786;19413.708794368096;19845.404637860887;6261.5616906816085;6282.434580887742;6284.528660350492;6311.495080393649;6473.870522589522;3587.1032241939515;3682.7237957152784;3699.6855267302044;3729.067733066733;3807.162424266657;3037.635483741921;3176.5870436843525;3200.055983484831;3204.0548038328284;3210.4381733196597;531.9680819150864;532.6138549551545;542.5659472422046;543.8857839853596;558.6815515156322;558.6787597131665;591.3642833953431;593.2821286243608;595.3540408656656;600.9008513595207;8406.453580517247;8439.282660973886;8501.17434687865;8534.87197692035;8594.355423343275;482.48133256749134;578.7800635758385;619.1115748900343;631.3213295707042;635.7298148287052;3818.59904710007;4037.9192416151513;4141.254574176677;4151.398047283127;4311.180875633682;86588.56705716431;87108;88959;90699.5465022684;91121;80138.49230432486;81435;81830.59084704539;82817;83088;65965;71711;71869.6406517964;71902.64048679723;74208.62895685487;8163.591820409075;8264.628091736007;8355.12271211514;8481.321494280319;8537.82924341522;41358.37962430626;41948.37077443902;41948.580514194466;43752.34371484494;44173.779131105424;57488.42511574831;57937.13094303673;59949;60761.39238607734;60777.39222607717;9817.460039697886;9864.556094975887;9976.50117494137;10053.246006549683;10128.291019628556;10972.670819875417;11100.444977751242;11170.553177872795;11622.6513204604;11643.88356116428;10845.295055821662;11047.447627618427;11059.612913547988;11668.416579171177;11746.58886938953;10601.098906593026;10704.518296676824;10828.512716927915;11182.832257516306;11254.437278136224;10653.733656658645;10758.838617420588;10822.621208257673;11194.496247668712;11526.250793698382;8604.827903442021;8975.102489751234;9145.131212534798;9193.908060919306;9613.134817866425;9207.585658645243;9395.85906211421;9595.568199430903;9648.421094734338;9781.119699227103 04:40:07 INFO - PROCESS | 9894 | __end_tp_report 04:40:07 INFO - PROCESS | 9894 | __start_cc_report 04:40:07 INFO - PROCESS | 9894 | _x_x_mozilla_cycle_collect,1230 04:40:07 INFO - PROCESS | 9894 | __end_cc_report 04:40:07 INFO - PROCESS | 9894 | __startTimestamp1476790807339__endTimestamp 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | ------- Summary: start ------- 04:40:07 INFO - PROCESS | 9894 | Number of tests: 6 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | [#0] dojo.html Cycles:165 Average:4718.57 Median:4851.08 stddev:502.81 (10.4%) stddev-sans-first:476.26 04:40:07 INFO - PROCESS | 9894 | Values: 2606.1 2618.6 2643.9 2661.4 2673.9 4643.8 4726.4 4802.8 4822.9 4832.3 4766.9 4768.7 4775.0 4778.4 4778.5 4362.1 4378.1 4401.2 4419.3 4426.2 4384.1 4391.0 4411.7 4415.6 4429.5 4375.4 4378.2 4391.0 4425.2 4455.3 4451.4 4459.2 4464.6 4474.7 4494.4 4290.6 4327.8 4340.2 4372.2 4427.2 4707.2 4745.0 4746.6 4774.3 4776.8 5050.2 5076.5 5108.2 5136.7 5147.4 4980.3 5031.0 5036.5 5149.0 5169.3 4743.2 4776.3 4781.4 4789.4 4851.1 5229.0 5233.7 5239.9 5244.8 5299.0 4910.7 5011.6 5018.8 5025.7 5030.8 5032.9 5089.5 5104.9 5113.8 5126.0 5091.4 5094.0 5099.4 5141.4 5170.4 5063.9 5077.8 5088.1 5088.3 5150.2 4271.6 4309.7 4317.7 4325.1 4328.3 3774.5 3785.4 3840.6 3843.0 3854.2 4304.2 4339.6 4340.8 4343.6 4400.1 4957.5 4974.1 4974.4 5088.3 5100.3 4234.8 4252.9 4253.0 4259.9 4265.0 4498.2 4526.3 4539.6 4589.2 4617.3 4824.1 4875.9 4879.4 4881.1 4886.3 5128.9 5129.5 5132.7 5145.9 5206.5 4656.5 4775.0 4830.6 4835.3 4841.5 4990.5 5035.4 5063.7 5081.5 5144.2 5126.4 5156.2 5172.4 5172.9 5175.5 5022.8 5023.0 5023.3 5024.8 5080.6 4874.8 4930.5 4930.8 4962.6 5006.0 4955.4 4961.9 4963.0 5007.6 5022.2 5053.0 5059.1 5060.4 5065.9 5123.5 4779.5 4834.3 4852.2 4945.5 4945.6 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | [#1] ext.html Cycles:180 Average:45602.19 Median:35060.56 stddev:80898.23 (230.7%) stddev-sans-first:81054.48 04:40:07 INFO - PROCESS | 9894 | Values: 559.8 560.3 566.0 579.9 583.0 28227.6 28847.1 39146.2 39620.8 39925.0 39283.4 39747.6 39804.6 39838.2 39846.0 7624.2 7773.4 7783.4 7783.8 7787.0 7519.0 7606.1 7609.0 7609.5 7613.0 7598.5 7636.5 7644.9 7646.8 7648.8 7583.4 7604.5 7617.0 7618.5 7623.8 7385.5 7441.7 7442.6 7443.6 7444.5 37325.4 37767.1 37778.0 37781.2 37919.4 3018.4 3198.5 3573.1 3591.8 3643.7 27035.2 27591.7 27765.9 29528.0 29759.4 3107.5 3142.7 3146.0 3185.8 3189.3 241042.0 241456.0 242043.0 242692.0 243501.0 52598.7 52937.7 52995.7 52996.6 53121.5 31785.8 32264.5 32297.2 34010.5 55405.7 13740.5 13877.6 13881.3 13899.5 13900.8 10398.4 10464.0 10482.4 10483.2 10487.8 17125.4 17189.7 17226.7 17260.7 17270.1 6793.4 6795.4 6911.2 6917.8 7013.9 751.6 759.9 845.5 899.5 984.2 25615.7 26735.1 26814.2 27249.5 27367.7 769.1 898.4 924.6 939.3 975.5 13344.3 13770.7 14396.1 14459.0 14477.5 343678.0 351332.0 351753.0 352617.0 353181.0 47826.8 48203.3 48255.3 48325.8 48329.0 1073.2 1086.0 1091.1 1167.6 1178.5 26339.7 28408.6 30995.7 31872.2 31920.2 51008.5 53016.7 53064.9 53078.7 53152.5 319134.0 320062.0 320434.0 321017.0 321859.0 24820.3 25051.6 25195.7 37198.6 37638.2 41060.8 41494.0 41521.6 41561.8 41744.0 34719.5 34738.5 34848.0 34918.7 35015.3 34219.3 34472.7 34797.7 34949.7 35105.8 29888.0 30470.1 33233.7 33359.7 33519.3 30478.0 31798.5 32333.8 32345.8 32778.8 24173.4 24242.2 24339.8 24502.4 24880.9 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | [#2] jquery.html Cycles:180 Average:24869.86 Median:4978.77 stddev:61914.12 (1243.6%) stddev-sans-first:62060.42 04:40:07 INFO - PROCESS | 9894 | Values: 342.4 355.6 356.3 360.5 382.5 15060.2 15342.2 16431.0 16590.5 16747.4 15730.3 15782.7 16034.3 16223.9 16259.5 4731.6 4990.4 5109.9 5135.2 5138.9 4967.2 5075.7 5076.9 5080.3 5082.4 4998.9 6403.2 6696.9 6724.2 6724.4 6662.3 6769.0 6809.8 6812.6 6898.4 6655.4 6677.7 6711.9 6715.8 6721.7 20886.8 21989.3 22220.9 22351.2 22620.8 1933.3 2023.1 2186.6 2200.2 2631.5 13978.5 14039.9 14279.4 14312.0 15001.2 1808.6 1849.9 1895.9 1924.2 1937.0 78992.0 83081.8 83251.6 83340.6 84213.0 15598.8 15658.9 15693.9 16241.1 16274.2 27664.9 27802.3 28020.2 28046.0 28179.0 7881.1 8097.3 8131.2 8337.4 8811.6 6402.3 6458.7 6574.3 6753.4 6949.2 7765.5 7953.0 8053.4 8088.5 8090.2 2993.8 3129.8 3153.8 3199.6 3338.6 702.2 827.0 860.2 864.7 871.6 15117.7 15325.9 15899.8 15985.2 16402.5 813.4 823.8 824.3 831.5 869.3 8195.9 8317.1 8529.2 8761.5 9131.9 364163.0 371625.0 375677.0 376587.0 378554.0 71831.3 75306.6 77515.6 77936.2 78467.0 843.6 866.7 867.4 869.1 869.9 14127.8 14191.9 14269.4 14314.9 14567.9 34905.5 35200.1 35934.9 36277.8 37539.2 46757.8 49106.4 49335.8 49514.8 51180.7 4545.6 4581.5 6839.4 7208.4 7283.8 9486.9 10765.0 11429.6 11482.4 11799.1 9942.4 10022.5 10121.1 10183.5 10410.6 9925.6 10043.4 10134.5 10155.7 10286.5 9583.8 9588.6 9727.6 9882.7 9945.7 7479.4 7586.0 7684.1 7691.3 7712.8 9220.3 9506.4 9697.6 9776.2 10023.8 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | [#3] mootools.html Cycles:180 Average:4904.96 Median:5313.81 stddev:2682.66 (50.5%) stddev-sans-first:2675.95 04:40:07 INFO - PROCESS | 9894 | Values: 1228.9 1358.3 1398.2 1462.8 1702.9 6345.0 6868.7 6959.3 7083.2 7195.2 7308.4 7310.1 7314.5 7339.4 7340.4 2131.4 2159.7 2163.7 2164.2 2168.1 2126.0 2168.6 2175.0 2175.6 2179.2 2115.7 2118.9 2123.8 2125.4 2181.7 2035.5 2130.9 2133.4 2140.9 2141.9 2081.7 2137.3 2145.3 2153.9 2156.1 7447.4 7465.4 7477.1 7486.9 7498.8 4313.2 4384.1 4469.9 4530.9 4531.3 2779.9 2830.2 2926.4 2936.5 2939.4 857.6 863.8 876.7 884.4 901.9 9500.8 9866.1 10017.4 10060.1 10124.9 3950.2 4000.8 4144.8 4150.7 4207.4 8570.3 8605.8 8642.5 8643.0 8643.4 4560.5 4570.8 4588.3 4594.2 4596.5 3613.5 3738.7 4045.5 4149.5 4152.4 3439.0 3502.1 3562.3 3600.6 3611.9 1108.1 1124.4 1136.6 1142.6 1156.8 766.7 781.9 814.4 843.1 843.4 4839.2 4969.4 5059.6 5103.4 5142.1 785.7 786.7 797.4 879.7 883.1 3419.0 3480.8 3557.1 3577.8 3607.2 9193.6 9446.6 9464.5 9492.1 9516.6 8336.9 9139.5 9148.2 9157.4 9218.2 6656.9 6935.1 6947.6 6950.9 6959.5 5076.7 5195.2 5273.2 5354.5 5377.7 8007.9 8070.5 8237.7 8243.6 8262.5 8129.1 8406.7 8515.7 8526.8 8588.1 6112.6 6295.5 6374.0 6527.6 6538.6 7044.5 7064.3 7066.1 7094.9 7101.3 6202.1 6386.3 6406.2 6562.5 6572.2 6330.7 6370.7 6388.9 6404.4 6466.9 6179.7 6258.2 6259.9 6267.2 6277.4 4474.4 4498.4 4504.0 4564.3 4654.1 4305.7 4315.7 4318.5 4321.7 4342.3 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | [#4] prototype.html Cycles:180 Average:4161.31 Median:4684.60 stddev:1232.39 (26.3%) stddev-sans-first:1201.15 04:40:07 INFO - PROCESS | 9894 | Values: 292.3 292.3 297.8 307.8 308.1 4902.9 4927.5 4932.1 4967.1 5006.8 4846.7 4860.8 4893.1 4894.7 4910.2 3869.3 3873.3 3893.0 3907.9 3911.5 3737.4 3886.1 3891.5 3896.1 3910.7 3802.0 3825.0 3825.6 3834.2 3869.3 3775.2 3800.4 3811.4 3814.5 3822.5 3084.8 3168.3 3229.9 3380.5 3381.8 4657.3 4661.6 4668.6 4678.8 4692.4 4278.0 4301.3 4310.8 4310.8 4310.8 4712.8 4830.2 5027.9 5051.0 5100.4 3640.1 3658.8 3659.5 3660.8 3664.7 5293.7 5305.8 5306.1 5310.0 5310.2 3481.2 3619.5 3744.5 3765.1 3770.3 3689.6 3694.2 3695.5 3704.0 3716.7 4221.7 4222.3 4233.5 4234.5 4235.7 5021.2 5051.7 5061.7 5067.1 5077.4 1218.6 1278.5 1283.4 1297.2 1301.3 797.0 809.3 820.1 827.3 827.5 3952.2 3971.5 3971.8 4010.7 4022.2 4530.8 4535.5 4547.9 4560.4 4600.7 3956.9 3960.2 3970.0 3972.5 3979.6 2324.4 2408.2 2437.9 2449.6 2467.0 4361.1 4672.2 4797.2 4815.8 4911.0 5309.4 5344.0 5358.5 5361.9 5370.2 4897.4 4919.9 4922.5 4923.4 4941.4 5069.9 5157.6 5205.8 5227.7 5237.7 5134.9 5137.5 5162.4 5170.7 5176.6 4690.4 4916.5 4916.8 4920.3 4945.3 3637.5 3650.3 3654.9 3655.6 3656.5 5224.2 5236.6 5238.5 5243.0 5249.3 5094.8 5106.7 5128.5 5145.8 5156.7 4853.0 5101.8 5124.8 5129.3 5150.4 5028.4 5030.5 5040.9 5055.5 5069.0 4972.3 5177.6 5179.5 5183.6 5200.0 4988.5 4994.5 4997.8 5028.2 5033.2 04:40:07 INFO - PROCESS | 9894 | 04:40:07 INFO - PROCESS | 9894 | [#5] yui.html Cycles:180 Average:17120.66 Median:591.28 stddev:24076.54 (4071.9%) stddev-sans-first:24112.28 04:40:07 INFO - PROCESS | 9894 | Values: 638.5 689.3 695.7 703.5 718.1 12151.0 12952.4 12960.7 12977.5 13049.1 13253.6 13286.3 13426.9 13438.5 13452.1 615.6 632.7 736.6 760.2 767.0 747.3 765.9 767.3 767.6 774.4 825.1 827.2 827.3 827.6 827.8 649.8 667.8 819.8 819.9 820.4 575.2 591.0 591.3 591.3 595.6 12469.3 12470.1 12474.6 12485.6 12491.4 11306.5 12122.8 12148.5 12176.1 12951.2 11473.9 11682.3 11725.4 11791.9 12239.1 3946.0 3958.5 4007.6 4106.4 4150.7 61521.7 63159.1 63658.4 64166.4 64241.4 9732.9 9754.8 9865.0 9902.3 10086.4 19118.0 19119.5 19143.9 19413.7 19845.4 6261.6 6282.4 6284.5 6311.5 6473.9 3587.1 3682.7 3699.7 3729.1 3807.2 3037.6 3176.6 3200.1 3204.1 3210.4 532.0 532.6 542.6 543.9 558.7 558.7 591.4 593.3 595.4 600.9 8406.5 8439.3 8501.2 8534.9 8594.4 482.5 578.8 619.1 631.3 635.7 3818.6 4037.9 4141.3 4151.4 4311.2 86588.6 87108.0 88959.0 90699.5 91121.0 80138.5 81435.0 81830.6 82817.0 83088.0 65965.0 71711.0 71869.6 71902.6 74208.6 8163.6 8264.6 8355.1 8481.3 8537.8 41358.4 41948.4 41948.6 43752.3 44173.8 57488.4 57937.1 59949.0 60761.4 60777.4 9817.5 9864.6 9976.5 10053.2 10128.3 10972.7 11100.4 11170.6 11622.7 11643.9 10845.3 11047.4 11059.6 11668.4 11746.6 10601.1 10704.5 10828.5 11182.8 11254.4 10653.7 10758.8 10822.6 11194.5 11526.3 8604.8 8975.1 9145.1 9193.9 9613.1 9207.6 9395.9 9595.6 9648.4 9781.1 04:40:07 INFO - PROCESS | 9894 | -------- Summary: end -------- 04:40:07 INFO - PROCESS | 9894 | 04:40:08 INFO - TEST-INFO | 9894: exit 0 04:40:08 INFO - TEST-OK | dromaeo_css | took 1122558ms 04:40:08 INFO - TEST-START | kraken 04:40:08 INFO - operating with platform_type : linux_ 04:40:08 INFO - Initialising browser for kraken test... 04:40:08 INFO - TEST-INFO | started process 10201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR09yHp/profile http://localhost:50343/getInfo.html) 04:40:12 INFO - PROCESS | 10201 | __metrics Screen width/height:1600/1200 04:40:12 INFO - PROCESS | 10201 | colorDepth:24 04:40:12 INFO - PROCESS | 10201 | Browser inner width/height: 1024/697 04:40:12 INFO - PROCESS | 10201 | __metrics 04:40:13 INFO - PROCESS | 10201 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:40:13 INFO - PROCESS | 10201 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:13 INFO - PROCESS | 10201 | console.error: PushService: 04:40:13 INFO - PROCESS | 10201 | stateChangeProcessEnqueue: Error transitioning state 04:40:13 INFO - PROCESS | 10201 | UnknownError 04:40:14 INFO - TEST-INFO | 10201: exit 0 04:40:14 INFO - Browser initialized. 04:40:14 INFO - Running cycle 1/1 for kraken test... 04:40:14 INFO - TEST-INFO | started process 10285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR09yHp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:26 INFO - PROCESS | 10285 | RSS: Main: 173408256 04:40:26 INFO - PROCESS | 10285 | 04:40:29 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:30 INFO - PROCESS | 10285 | RSS: Main: 230060032 04:40:30 INFO - PROCESS | 10285 | 04:40:33 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-dft) 04:40:33 INFO - PROCESS | 10285 | RSS: Main: 217542656 04:40:33 INFO - PROCESS | 10285 | 04:40:37 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-fft) 04:40:37 INFO - PROCESS | 10285 | RSS: Main: 300015616 04:40:37 INFO - PROCESS | 10285 | 04:40:39 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-oscillator) 04:40:40 INFO - PROCESS | 10285 | RSS: Main: 210104320 04:40:40 INFO - PROCESS | 10285 | 04:40:42 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:43 INFO - PROCESS | 10285 | RSS: Main: 212824064 04:40:43 INFO - PROCESS | 10285 | 04:40:46 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50343/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:47 INFO - PROCESS | 10285 | RSS: Main: 248942592 04:40:47 INFO - PROCESS | 10285 | 04:40:50 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50343/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:51 INFO - PROCESS | 10285 | RSS: Main: 247844864 04:40:51 INFO - PROCESS | 10285 | 04:40:53 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50343/tests/kraken/driver.html?testName=json-parse-financial) 04:40:54 INFO - PROCESS | 10285 | RSS: Main: 246927360 04:40:54 INFO - PROCESS | 10285 | 04:40:56 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:56 INFO - PROCESS | 10285 | RSS: Main: 209711104 04:40:56 INFO - PROCESS | 10285 | 04:40:58 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:59 INFO - PROCESS | 10285 | RSS: Main: 216948736 04:40:59 INFO - PROCESS | 10285 | 04:41:01 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:02 INFO - PROCESS | 10285 | RSS: Main: 226304000 04:41:02 INFO - PROCESS | 10285 | 04:41:04 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:05 INFO - PROCESS | 10285 | RSS: Main: 234582016 04:41:05 INFO - PROCESS | 10285 | 04:41:08 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:09 INFO - PROCESS | 10285 | RSS: Main: 231968768 04:41:09 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50343/tests/kraken/driver.html?testName=ai-astar) 04:41:11 INFO - PROCESS | 10285 | RSS: Main: 282734592 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | __start_tp_report 04:41:11 INFO - PROCESS | 10285 | _x_x_mozilla_page_load 04:41:11 INFO - PROCESS | 10285 | _x_x_mozilla_page_load_details 04:41:11 INFO - PROCESS | 10285 | |i|pagename|runs| 04:41:11 INFO - PROCESS | 10285 | |0;ai-astar;106;115;113;115;115;116;115;115;116;114 04:41:11 INFO - PROCESS | 10285 | |1;audio-beat-detection;152;127;126;165;129;127;126;128;156;126 04:41:11 INFO - PROCESS | 10285 | |2;audio-dft;160;160;161;161;162;163;163;161;162;163 04:41:11 INFO - PROCESS | 10285 | |3;audio-fft;76;76;76;112;76;76;76;76;98;75 04:41:11 INFO - PROCESS | 10285 | |4;audio-oscillator;85;83;112;85;84;84;117;85;84;114 04:41:11 INFO - PROCESS | 10285 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;117;118 04:41:11 INFO - PROCESS | 10285 | |6;imaging-darkroom;147;146;146;146;147;146;146;147;147;145 04:41:11 INFO - PROCESS | 10285 | |7;imaging-desaturate;85;84;84;84;85;84;85;84;84;84 04:41:11 INFO - PROCESS | 10285 | |8;json-parse-financial;65;66;64;64;64;65;65;66;64;65 04:41:11 INFO - PROCESS | 10285 | |9;json-stringify-tinderbox;67;68;67;67;68;71;71;67;70;67 04:41:11 INFO - PROCESS | 10285 | |10;stanford-crypto-aes;93;83;85;84;84;82;84;83;84;89 04:41:11 INFO - PROCESS | 10285 | |11;stanford-crypto-ccm;142;138;140;149;144;146;138;138;182;144 04:41:11 INFO - PROCESS | 10285 | |12;stanford-crypto-pbkdf2;185;183;191;186;184;179;177;177;178;179 04:41:11 INFO - PROCESS | 10285 | |13;stanford-crypto-sha256-iterative;71;71;72;72;70;72;71;70;68;71 04:41:11 INFO - PROCESS | 10285 | __end_tp_report 04:41:11 INFO - PROCESS | 10285 | __start_cc_report 04:41:11 INFO - PROCESS | 10285 | _x_x_mozilla_cycle_collect,1934 04:41:11 INFO - PROCESS | 10285 | __end_cc_report 04:41:11 INFO - PROCESS | 10285 | __startTimestamp1476790871390__endTimestamp 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | ------- Summary: start ------- 04:41:11 INFO - PROCESS | 10285 | Number of tests: 14 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 04:41:11 INFO - PROCESS | 10285 | Values: 106.0 115.0 113.0 115.0 115.0 116.0 115.0 115.0 116.0 114.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:128.50 stddev:15.17 (11.8%) stddev-sans-first:14.98 04:41:11 INFO - PROCESS | 10285 | Values: 152.0 127.0 126.0 165.0 129.0 127.0 126.0 128.0 156.0 126.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.09 04:41:11 INFO - PROCESS | 10285 | Values: 160.0 160.0 161.0 161.0 162.0 163.0 163.0 161.0 162.0 163.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.72 (16.7%) stddev-sans-first:13.32 04:41:11 INFO - PROCESS | 10285 | Values: 76.0 76.0 76.0 112.0 76.0 76.0 76.0 76.0 98.0 75.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:84.00 stddev:14.58 (17.4%) stddev-sans-first:15.15 04:41:11 INFO - PROCESS | 10285 | Values: 85.0 83.0 112.0 85.0 84.0 84.0 117.0 85.0 84.0 114.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 04:41:11 INFO - PROCESS | 10285 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 04:41:11 INFO - PROCESS | 10285 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 145.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 04:41:11 INFO - PROCESS | 10285 | Values: 85.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 84.0 84.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 04:41:11 INFO - PROCESS | 10285 | Values: 65.0 66.0 64.0 64.0 64.0 65.0 65.0 66.0 64.0 65.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:1.74 04:41:11 INFO - PROCESS | 10285 | Values: 67.0 68.0 67.0 67.0 68.0 71.0 71.0 67.0 70.0 67.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:3.35 (4.0%) stddev-sans-first:1.99 04:41:11 INFO - PROCESS | 10285 | Values: 93.0 83.0 85.0 84.0 84.0 82.0 84.0 83.0 84.0 89.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:144.00 stddev:13.15 (9.1%) stddev-sans-first:13.87 04:41:11 INFO - PROCESS | 10285 | Values: 142.0 138.0 140.0 149.0 144.0 146.0 138.0 138.0 182.0 144.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:183.50 stddev:4.65 (2.5%) stddev-sans-first:4.80 04:41:11 INFO - PROCESS | 10285 | Values: 185.0 183.0 191.0 186.0 184.0 179.0 177.0 177.0 178.0 179.0 04:41:11 INFO - PROCESS | 10285 | 04:41:11 INFO - PROCESS | 10285 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 04:41:11 INFO - PROCESS | 10285 | Values: 71.0 71.0 72.0 72.0 70.0 72.0 71.0 70.0 68.0 71.0 04:41:11 INFO - PROCESS | 10285 | -------- Summary: end -------- 04:41:11 INFO - PROCESS | 10285 | 04:41:12 INFO - TEST-INFO | 10285: exit 0 04:41:12 INFO - TEST-OK | kraken | took 64411ms 04:41:12 INFO - SUITE-END | took 1186s 04:41:13 INFO - Completed test suite (00:19:47) 04:41:13 INFO - javascript benchmark 04:41:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.0618177456113, 2618.5810270356747, 2643.8678066096695, 2661.4144888124606, 2673.933151671208, 4643.7910294036765, 4726.409198850144, 4802.783874725637, 4822.903541929164, 4832.347633069535, 4766.904661906759, 4768.690035147713, 4774.976125119379, 4778.378810754606, 4778.4743678195455, 4362.0839623678985, 4378.080603073358, 4401.185780630578, 4419.270820314644, 4426.15902978433, 4384.101259241847, 4391.033972526056, 4411.691181617288, 4415.558444155575, 4429.468463784334, 4375.38744575758, 4378.1681480518755, 4391.0, 4425.203463376591, 4455.309427038798, 4451.399061126739, 4459.175052615276, 4464.55354464551, 4474.731516109011, 4494.37078808967, 4290.592393722592, 4327.805248763813, 4340.175366680321, 4372.2130016597, 4427.158839820456, 4707.246840505537, 4745.0, 4746.644001699887, 4774.259989701602, 4776.832810851603, 5050.242463630448, 5076.466970968032, 5108.157154069574, 5136.717480538568, 5147.4080480744815, 4980.2778597103215, 5031.018951304461, 5036.546710796009, 5148.9959457905725, 5169.302144210521, 4743.217369134123, 4776.259679749644, 4781.378420805273, 4789.353437285922, 4851.078295123915, 5229.006488767122, 5233.659812112201, 5239.947600524022, 5244.842654720364, 5298.97350513245, 4910.705357678551, 5011.574016208663, 5018.799248030111, 5025.748712564357, 5030.8239211627415, 5032.899342013139, 5089.541941225308, 5104.897902041938, 5113.846584602394, 5125.974370128126, 5091.439941606421, 5093.974530127326, 5099.388073431212, 5141.408737995179, 5170.353705786777, 5063.8987220255385, 5077.822276220315, 5088.0587091388215, 5088.287639730441, 5150.150225212873, 4271.594198551133, 4309.6767742418815, 4317.654587632982, 4325.070109926381, 4328.329108988112, 3774.471573979645, 3785.432185172246, 3840.558335791364, 3842.9807850960565, 3854.1520865409566, 4304.182205380967, 4339.5660433956355, 4340.804663790137, 4343.609075183249, 4400.141972315432, 4957.529034741694, 4974.129527332702, 4974.353334066621, 5088.313077734459, 5100.336956195671, 4234.830606775756, 4252.893677658083, 4253.000544871953, 4259.893502662459, 4264.978675106605, 4498.235299999008, 4526.253168227271, 4539.568740969603, 4589.242774942164, 4617.3304870793545, 4824.131656301759, 4875.902481950412, 4879.365682461257, 4881.072596206852, 4886.340344053508, 5128.948710512847, 5129.538341549279, 5132.7177005263575, 5145.897082058413, 5206.453322401245, 4656.534346565317, 4774.95225047759, 4830.589399901048, 4835.298881662069, 4841.515848415131, 4990.451050384528, 5035.446100928822, 5063.721495317793, 5081.517255860687, 5144.228365745168, 5126.384833819965, 5156.20078887773, 5172.353455818023, 5172.922406163835, 5175.534201921694, 5022.84931452057, 5023.0, 5023.2716256143385, 5024.773885175249, 5080.618953578571, 4874.7562621868055, 4930.482299358516, 4930.827421040246, 4962.5533701967, 5005.974970125126, 4955.380577427822, 4961.925571116364, 4962.975185124052, 5007.599392048554, 5022.1964485683575, 5053.0, 5059.139946209079, 5060.3927528696795, 5065.8733531662, 5123.538881500683, 4779.498152693917, 4834.347363106076, 4852.199387101089, 4945.4807245238735, 4945.646753764921], "value": 4685.818186037348, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.7956745787784, 560.277242357359, 565.9773609055638, 579.9271348006189, 582.9768755833513, 28227.576586351195, 28847.134585962427, 39146.217075658504, 39620.80189599055, 39925.0, 39283.410748838716, 39747.602523974754, 39804.601953980455, 39838.20323593527, 39846.0, 7624.161342252348, 7773.416993725465, 7783.4162437817395, 7783.76648700537, 7786.961065194666, 7518.962405187994, 7606.125295591022, 7608.961955190216, 7609.467337286392, 7613.0483689538805, 7598.506097103671, 7636.4654474186555, 7644.923550764477, 7646.770596882103, 7648.808779780495, 7583.393328533704, 7604.54372737632, 7617.047869016373, 7618.542887426772, 7623.771286861375, 7385.519941203858, 7441.665125069385, 7442.627868606548, 7443.59060251686, 7444.516106453063, 37325.44011839825, 37767.05582360436, 37778.0, 37781.24437511234, 37919.43120853162, 3018.44158830617, 3198.504231844068, 3573.1424458130123, 3591.8204089795404, 3643.653852883972, 27035.1889443317, 27591.724082759116, 27765.861170694017, 29528.0, 29759.404811903856, 3107.4717298059386, 3142.6700196479496, 3145.968540314613, 3185.792923459968, 3189.282411457427, 241042.0, 241456.0, 242043.0, 242692.0, 243501.0, 52598.737006314725, 52937.735311323195, 52995.73502132465, 52996.6404031511, 53121.46878531243, 31785.841070794497, 32264.516032259537, 32297.192570185933, 34010.48984265238, 55405.72297138489, 13740.519081832288, 13877.583672489842, 13881.305934703225, 13899.513517027057, 13900.791488127687, 10398.376097434028, 10464.0, 10482.371057736407, 10483.161347092215, 10487.790244195074, 17125.400610978555, 17189.656206875792, 17226.741598876026, 17260.654786904444, 17270.064089104882, 6793.422559082434, 6795.422389096883, 6911.17065952089, 6917.792466226021, 7013.92986070143, 751.5678484871221, 759.9240075992467, 845.4969293270494, 899.532243233528, 984.1978787288338, 25615.743842561707, 26735.121687720282, 26814.195574132806, 27249.455010900067, 27367.72632273652, 769.1270408086862, 898.4025622960788, 924.5793164110314, 939.2532936315646, 975.5171190260867, 13344.332783360793, 13770.724585508233, 14396.064255823547, 14459.0, 14477.493287734878, 343678.0, 351332.0, 351753.0, 352617.0, 353181.0, 47826.76086619614, 48203.276950845764, 48255.27617085746, 48325.75837120792, 48329.0, 1073.2433634287809, 1086.0334302470808, 1091.0507858163448, 1167.550493060161, 1178.4814681540095, 26339.736602634493, 28408.57387139153, 30995.69004309928, 31872.203194920312, 31920.201994950312, 51008.48991510186, 53016.73491632517, 53064.93870122653, 53078.73460632672, 53152.4684753163, 319134.0, 320062.0, 320434.0, 321017.0, 321859.0, 24820.25539233826, 25051.624225636264, 25195.74804251934, 37198.62801371951, 37638.2472350546, 41060.79469602633, 41494.0, 41521.584784151775, 41561.792191038854, 41744.0, 34719.4792078114, 34738.47892281567, 34848.0, 34918.65081349154, 35015.299694005465, 34219.315613688086, 34472.655273446944, 34797.652023480456, 34949.65050349464, 35105.82447087748, 29888.0, 30470.085897422225, 33233.66766332306, 33359.66640333566, 33519.32961340808, 30478.0, 31798.523022154222, 32333.838330808194, 32345.838270809436, 32778.83610581932, 24173.395665108514, 24242.15152469655, 24339.756602434456, 24502.387440314134, 24880.87559562263], "value": 16999.761031318518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3956716395561, 355.6248158193106, 356.2820915854552, 360.4701089398584, 382.4626399908128, 15060.246987650615, 15342.23288835558, 16431.0, 16590.50228493144, 16747.4138405156, 15730.292136853841, 15782.684346313066, 16034.278457469412, 16223.918880405581, 16259.51221463355, 4731.597814185799, 4990.351254336932, 5109.923351149736, 5135.152699804527, 5138.897222055557, 4967.180415231501, 5075.695458272497, 5076.873078173038, 5080.263361812554, 5082.440931497532, 4998.875028124307, 6403.167588213549, 6696.8995465068065, 6724.159480064992, 6724.394804467622, 6662.333766623347, 6768.966155169217, 6809.795706128799, 6812.62530560819, 6898.379145876896, 6655.401013908723, 6677.732890684367, 6711.865762684768, 6715.764948226837, 6721.731130754764, 20886.791132088638, 21989.340319790434, 22220.888895555418, 22351.217707380325, 22620.773792262196, 1933.2943475631293, 2023.1300540767463, 2186.5517568898495, 2200.1639377036786, 2631.5131700635443, 13978.510752123728, 14039.929800350932, 14279.357428915724, 14311.998160128795, 15001.249937503082, 1808.638272345536, 1849.9075046247633, 1895.9431217063373, 1924.191839427444, 1937.0218039889764, 78992.0, 83081.75377369404, 83251.58374208151, 83340.58329708374, 84213.0, 15598.844011559739, 15658.946505431331, 15693.921530392276, 16241.106739129225, 16274.186290685418, 27664.861675691896, 27802.3049423762, 28020.159395217768, 28046.0, 28179.0, 7881.093674227537, 8097.346227091639, 8131.227533384319, 8337.374696897636, 8811.647534098563, 6402.295747467775, 6458.741650333934, 6574.285528676282, 6753.358430949052, 6949.166100068024, 7765.53406795594, 7953.0, 8053.395995300376, 8088.459405307383, 8090.1909809018625, 2993.7546839870097, 3129.8122112673313, 3153.805438766435, 3199.6162858669973, 3338.5993680758465, 702.1580450650539, 827.0034608296987, 860.1871231686122, 864.7196377929275, 871.5511511571545, 15117.697646047018, 15325.923370383076, 15899.761503577456, 15985.200739963188, 16402.507924762278, 813.3899575318511, 823.8064054947083, 824.3405275779353, 831.4678605692362, 869.3349587565517, 8195.877061844078, 8317.085120636724, 8529.189726975927, 8761.474311541328, 9131.863022054675, 364163.0, 371625.0, 375677.0, 376587.0, 378554.0, 71831.28168718246, 75306.62346688341, 77515.61242193753, 77936.22063779403, 78467.0, 843.5950743642964, 866.6966561703354, 867.4491697771961, 869.0614136732314, 869.9173578510031, 14127.788083178966, 14191.929040354733, 14269.42922283097, 14314.928425357806, 14567.927160364554, 34905.47641785426, 35200.11999699925, 35934.92195234147, 36277.818610906776, 37539.24921501609, 46757.766211168724, 49106.424247272866, 49335.75332123316, 49514.75242623908, 51180.74409627928, 4545.59089681917, 4581.450225972904, 6839.418649414656, 7208.387287080657, 7283.781486555412, 9486.905130948602, 10764.979900450084, 11429.59996400122, 11482.425878706199, 11799.115066370228, 9942.403455792675, 10022.498875056071, 10121.139703125316, 10183.490825458846, 10410.583576656849, 9925.602975881173, 10043.4476103815, 10134.543945522322, 10155.7461063474, 10286.485675716334, 9583.808323833346, 9588.56851441673, 9727.610895564098, 9882.703518894445, 9945.651902183388, 7479.439042071976, 7586.0, 7684.116326622287, 7691.30778229962, 7712.807179820549, 9220.26237900953, 9506.382085164441, 9697.6120955161, 9776.217902567636, 10023.799524009624], "value": 8857.502643502452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.8586812516564, 1358.2801115408831, 1398.223985687943, 1462.8390877003528, 1702.8978261304323, 6345.0, 6868.725250989961, 6959.2692767259405, 7083.220845706968, 7195.208527062019, 7308.378787803043, 7310.135915341581, 7314.524555903862, 7339.449541284412, 7340.412766978642, 2131.3925531223645, 2159.730033745782, 2163.7403511578555, 2164.2208804830248, 2168.143583284602, 2125.9893700531475, 2168.620491414004, 2174.967375489369, 2175.564887022594, 2179.1610230061383, 2115.6826476028564, 2118.8834614096218, 2123.8106660270223, 2125.362391282617, 2181.7054697615777, 2035.521652411682, 2130.9041093150845, 2133.3919832847564, 2140.9357719268446, 2141.9036143373587, 2081.739782527184, 2137.2519618133683, 2145.324222869807, 2153.91384344626, 2156.137544982004, 7447.44144189188, 7465.440091993068, 7477.065366829146, 7486.85026299471, 7498.8125296867465, 4313.1804957058375, 4384.12317536494, 4469.888252793674, 4530.909381812378, 4531.252343363341, 2779.8888044478194, 2830.2075418882746, 2926.356201635658, 2936.515474946653, 2939.4415061138316, 857.5712143928037, 863.7754183912228, 876.7238319929265, 884.3765145572356, 901.8737376767258, 9500.762480937963, 9866.062724041205, 10017.39895606266, 10060.144887684555, 10124.89875101247, 3950.229705207457, 4000.7799571023875, 4144.772037537964, 4150.709450338508, 4207.368894665825, 8570.271526920282, 8605.827883442296, 8642.481451112953, 8642.95678521616, 8643.438176518632, 4560.521145279764, 4570.794314255866, 4588.26587745959, 4594.19601569724, 4596.517365676623, 3613.5483064616924, 3738.6635202831876, 4045.5347635021762, 4149.543550209474, 4152.418661387408, 3438.9828050860087, 3502.0719509330047, 3562.2697347043795, 3600.6039335673054, 3611.9277614448088, 1108.14672702019, 1124.3759713359163, 1136.5681041204289, 1142.5943789954613, 1156.8380426740096, 766.6856588798565, 781.9257170568901, 814.4095530740284, 843.0599881132493, 843.3716880923629, 4839.153148199051, 4969.428515720666, 5059.620528460307, 5103.362079740033, 5142.125838607446, 785.7249962513075, 786.6735304848538, 797.3621103117483, 879.7316818370331, 883.1212943121635, 3418.9829050854587, 3480.7563470557325, 3557.0573797943566, 3577.7853328800356, 3607.1703508193264, 9193.586288617029, 9446.574904129193, 9464.526773661428, 9492.098250666175, 9516.619335226513, 8336.916630833735, 9139.451632902048, 9148.222401095982, 9157.358984871129, 9218.216451601555, 6656.8668626627195, 6935.098437203132, 6947.617881016593, 6950.930490695129, 6959.478039147084, 5076.7207803571155, 5195.246689230116, 5273.156294992783, 5354.464553544614, 5377.704226267593, 8007.879881801661, 8070.515769053875, 8237.711680091168, 8243.629036693483, 8262.545559994258, 8129.105798362294, 8406.747797566082, 8515.659373625233, 8526.82946341082, 8588.098249683693, 6112.572119951561, 6295.464885484785, 6374.0, 6527.575707579183, 6538.607683539003, 7044.542104763379, 7064.293570642894, 7066.116735408074, 7094.929050709633, 7101.254368291255, 6202.131701561695, 6386.329435409215, 6406.199225096863, 6562.507811914221, 6572.178477690289, 6330.746770129143, 6370.713317900613, 6388.93611063902, 6404.423601875854, 6466.870662586816, 6179.721912514037, 6258.249010118815, 6259.906101408392, 6267.185265915402, 6277.372262773686, 4474.440694913136, 4498.370228167993, 4504.031633198747, 4564.315352696989, 4654.092451971968, 4305.698601098018, 4315.719478233905, 4318.481782186032, 4321.654267658517, 4342.32693932441], "value": 3980.1615235295144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.28390443413645, 292.31306429889764, 297.7885701152182, 307.83838484795496, 308.0742369180612, 4902.901941961159, 4927.457979622243, 4932.112219800434, 4967.10592093423, 5006.849794506162, 4846.684965477241, 4860.781264843082, 4893.1436998525205, 4894.730789806559, 4910.165271903776, 3869.303525365433, 3873.3221686204943, 3892.9610703892954, 3907.948327128252, 3911.4915061042025, 3737.3646480098314, 3886.1061955750192, 3891.5330160380795, 3896.0649444133346, 3910.667593254577, 3802.049487628093, 3824.9808750956345, 3825.61743825618, 3834.2331533693373, 3869.3228684980018, 3775.188334508094, 3800.4489349044234, 3811.3520701480675, 3814.5123401873293, 3822.5412950445984, 3084.8457577121053, 3168.3188114555483, 3229.919252018695, 3380.459126539766, 3381.8140002299865, 4657.301404789275, 4661.627069834405, 4668.626509879202, 4678.836240731592, 4692.36653051837, 4277.967965216529, 4301.311790113598, 4310.806013729359, 4310.80601372939, 4310.849120280806, 4712.78792454337, 4830.178869592178, 5027.874303142414, 5051.0, 5100.438951715309, 3640.12636967126, 3658.835352409148, 3659.505966694489, 3660.7919386602357, 3664.6885014773775, 5293.708846013467, 5305.814296499604, 5306.071437498461, 5310.0, 5310.15906490026, 3481.1819222482695, 3619.475176099451, 3744.5319335083113, 3765.0963768695865, 3770.2647983643474, 3689.612590677994, 3694.1503454205144, 3695.519582454264, 3704.0, 3716.6840818530186, 4221.7255878367805, 4222.261104306734, 4233.5131459881895, 4234.513031001413, 4235.661147108224, 5021.221710634857, 5051.747412629354, 5061.721605311744, 5067.138586440314, 5077.365329333833, 1218.561317925546, 1278.4949944771763, 1283.3839756916732, 1297.2216669998115, 1301.3493253373313, 797.0, 809.2918696140877, 820.0856045509214, 827.3009307135461, 827.5034979012544, 3952.213689349002, 3971.543272523639, 3971.841126354971, 4010.7393019453643, 4022.1754540319166, 4530.841420550265, 4535.546445355504, 4547.930691535344, 4560.4071470708595, 4600.677952543289, 3956.8615098471414, 3960.20795840833, 3970.0, 3972.483577134954, 3979.5622481527007, 2324.4176691065195, 2408.157759314126, 2437.8668664918196, 2449.5835707929696, 2466.962995555068, 4361.0841723237845, 4672.2057250267535, 4797.208460603962, 4815.807367705323, 4911.0, 5309.389420216725, 5344.0, 5358.544523715528, 5361.865953351197, 5370.221317908881, 4897.3878265216845, 4919.900462708542, 4922.458529561745, 4923.409190897115, 4941.407031156285, 5069.935313584188, 5157.587393008625, 5205.817796377109, 5227.712475813867, 5237.685738855681, 5134.897302053863, 5137.537621614073, 5162.432132465501, 5170.689758614495, 5176.559992400688, 4690.366800481891, 4916.508349165055, 4916.803327866988, 4920.302495638999, 4945.282933974626, 3637.5453068366455, 3650.3170169925615, 3654.8720794772057, 3655.61616030313, 3656.5246517952496, 5224.219838847412, 5236.581073514186, 5238.528532432099, 5243.033862301637, 5249.291345668286, 5094.802721360551, 5106.744662766772, 5128.512791284822, 5145.819896303611, 5156.710822294426, 4853.0, 5101.826579886572, 5124.846254612367, 5129.2819005340025, 5150.433452320317, 5028.371453568304, 5030.496950305087, 5040.924386134137, 5055.469175736642, 5068.974655126701, 4972.279019542074, 5177.585793136464, 5179.48205179479, 5183.637145399936, 5200.0, 4988.528384126764, 4994.453937704271, 4997.775100120576, 5028.15346260104, 5033.245013247895], "value": 3767.883483483933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.4796390941384, 689.3038031588095, 695.6834640238689, 703.5216053083901, 718.1418205244732, 12151.0, 12952.35238238089, 12960.74078518429, 12977.545785897495, 13049.086563940527, 13253.602391928234, 13286.26925519096, 13426.932865335684, 13438.462461501553, 13452.125611835223, 615.572177336749, 632.7026297640102, 736.6280028585556, 760.228368206271, 766.9808254793647, 747.2714103748829, 765.9234076592352, 767.3094215206303, 767.6277005652254, 774.3882332956957, 825.0800357601262, 827.2224109337204, 827.3133299361546, 827.6482494939656, 827.7682248970298, 649.7855707616475, 667.8096742428385, 819.7950512371907, 819.9098099209082, 820.3683163963744, 575.1602660116235, 590.9881802363972, 591.2550186764664, 591.3081694417542, 595.600947365262, 12469.251844889244, 12470.127091103626, 12474.563390281388, 12485.56300529477, 12491.437885295183, 11306.491207895582, 12122.757544849053, 12148.45331960064, 12176.147669663127, 12951.222926624338, 11473.942630286878, 11682.29906205622, 11725.355105469196, 11791.941040294829, 12239.143259971806, 3945.9802700986597, 3958.5447673517624, 4007.6393124618926, 4106.404571337169, 4150.688698347636, 61521.69239153821, 63159.05261421082, 63658.363416365704, 64166.3583364165, 64241.35758642447, 9732.90267097334, 9754.804903901882, 9864.950675246579, 9902.306838521234, 10086.445245511568, 19118.044097795333, 19119.52201194981, 19143.904280478786, 19413.708794368096, 19845.404637860887, 6261.5616906816085, 6282.434580887742, 6284.528660350492, 6311.495080393649, 6473.870522589522, 3587.1032241939515, 3682.7237957152784, 3699.6855267302044, 3729.067733066733, 3807.162424266657, 3037.635483741921, 3176.5870436843525, 3200.055983484831, 3204.0548038328284, 3210.4381733196597, 531.9680819150864, 532.6138549551545, 542.5659472422046, 543.8857839853596, 558.6815515156322, 558.6787597131665, 591.3642833953431, 593.2821286243608, 595.3540408656656, 600.9008513595207, 8406.453580517247, 8439.282660973886, 8501.17434687865, 8534.87197692035, 8594.355423343275, 482.48133256749134, 578.7800635758385, 619.1115748900343, 631.3213295707042, 635.7298148287052, 3818.59904710007, 4037.9192416151513, 4141.254574176677, 4151.398047283127, 4311.180875633682, 86588.56705716431, 87108.0, 88959.0, 90699.5465022684, 91121.0, 80138.49230432486, 81435.0, 81830.59084704539, 82817.0, 83088.0, 65965.0, 71711.0, 71869.6406517964, 71902.64048679723, 74208.62895685487, 8163.591820409075, 8264.628091736007, 8355.12271211514, 8481.321494280319, 8537.82924341522, 41358.37962430626, 41948.37077443902, 41948.580514194466, 43752.34371484494, 44173.779131105424, 57488.42511574831, 57937.13094303673, 59949.0, 60761.39238607734, 60777.39222607717, 9817.460039697886, 9864.556094975887, 9976.50117494137, 10053.246006549683, 10128.291019628556, 10972.670819875417, 11100.444977751242, 11170.553177872795, 11622.6513204604, 11643.88356116428, 10845.295055821662, 11047.447627618427, 11059.612913547988, 11668.416579171177, 11746.58886938953, 10601.098906593026, 10704.518296676824, 10828.512716927915, 11182.832257516306, 11254.437278136224, 10653.733656658645, 10758.838617420588, 10822.621208257673, 11194.496247668712, 11526.250793698382, 8604.827903442021, 8975.102489751234, 9145.131212534798, 9193.908060919306, 9613.134817866425, 9207.585658645243, 9395.85906211421, 9595.568199430903, 9648.421094734338, 9781.119699227103], "value": 6455.565238623773, "unit": "score"}], "name": "dromaeo_css", "value": 6393.724030496574, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 113.0, 115.0, 115.0, 116.0, 115.0, 115.0, 116.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 126.0, 165.0, 129.0, 127.0, 126.0, 128.0, 156.0, 126.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 163.0, 163.0, 161.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 112.0, 76.0, 76.0, 76.0, 76.0, 98.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 112.0, 85.0, 84.0, 84.0, 117.0, 85.0, 84.0, 114.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 71.0, 71.0, 67.0, 70.0, 67.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 83.0, 85.0, 84.0, 84.0, 82.0, 84.0, 83.0, 84.0, 89.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 140.0, 149.0, 144.0, 146.0, 138.0, 138.0, 182.0, 144.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 191.0, 186.0, 184.0, 179.0, 177.0, 177.0, 178.0, 179.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 72.0, 70.0, 72.0, 71.0, 70.0, 68.0, 71.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1551.4999999999998, "alertThreshold": 2.0}]} 04:41:13 INFO - Return code: 0 04:41:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:13 INFO - # TBPL SUCCESS # 04:41:13 INFO - Running post-action listener: _resource_record_post_action 04:41:13 INFO - [mozharness: 2016-10-18 11:41:13.187353Z] Finished run-tests step (success) 04:41:13 INFO - Running post-run listener: _resource_record_post_run 04:41:13 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399839232; Read time: 8; Write time: 244260 04:41:13 INFO - TinderboxPrint: CPU usage
13.0% 04:41:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:41:13 INFO - TinderboxPrint: I/O write bytes / time
399,839,232 / 244,260 04:41:13 INFO - TinderboxPrint: CPU idle
8,345.8 (86.9%) 04:41:13 INFO - TinderboxPrint: CPU user
1,204.0 (12.5%) 04:41:13 INFO - TinderboxPrint: Swap in / out
0 / 0 04:41:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106389504; Read time: 0; Write time: 60676 04:41:13 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293449728; Read time: 0; Write time: 183584 04:41:13 INFO - Running post-run listener: _upload_blobber_files 04:41:13 INFO - Blob upload gear active. 04:41:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:41:13 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:41:13 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:41:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:17 INFO - (blobuploader) - INFO - Done attempting. 04:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:18 INFO - (blobuploader) - INFO - Done attempting. 04:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:19 INFO - (blobuploader) - INFO - Done attempting. 04:41:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:19 INFO - Return code: 0 04:41:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cca1f218d5aeb3548ef796f9f79fd2bb1e8893afb9eb71c96922529187c005795f60824e66a428dbc581c2ff80933d98ee0114f1b953f77307060d975a44b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30ed8e09d0f7ab32c2abbb8c870ae7144b52f4a65412f7cd78d889583eeadc89b1734db8693d80432131e07a2a5f2954df0f77cc50e149f00d1a2ff108600ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d9f0e60a03aa47c7505820348e1891aa522e978b7aed8bb1275dd21c155fe462d372b18c035e6fc7cfcf39fa7d7a2274d533b68df07b9a7e6150bbaf04447ad"} 04:41:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:19 INFO - Contents: 04:41:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cca1f218d5aeb3548ef796f9f79fd2bb1e8893afb9eb71c96922529187c005795f60824e66a428dbc581c2ff80933d98ee0114f1b953f77307060d975a44b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30ed8e09d0f7ab32c2abbb8c870ae7144b52f4a65412f7cd78d889583eeadc89b1734db8693d80432131e07a2a5f2954df0f77cc50e149f00d1a2ff108600ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d9f0e60a03aa47c7505820348e1891aa522e978b7aed8bb1275dd21c155fe462d372b18c035e6fc7cfcf39fa7d7a2274d533b68df07b9a7e6150bbaf04447ad"} 04:41:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:19 INFO - Copying logs to upload dir... 04:41:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.750540 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-18 04:41:18.655094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:41:18.658567) ========= 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=523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cca1f218d5aeb3548ef796f9f79fd2bb1e8893afb9eb71c96922529187c005795f60824e66a428dbc581c2ff80933d98ee0114f1b953f77307060d975a44b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30ed8e09d0f7ab32c2abbb8c870ae7144b52f4a65412f7cd78d889583eeadc89b1734db8693d80432131e07a2a5f2954df0f77cc50e149f00d1a2ff108600ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d9f0e60a03aa47c7505820348e1891aa522e978b7aed8bb1275dd21c155fe462d372b18c035e6fc7cfcf39fa7d7a2274d533b68df07b9a7e6150bbaf04447ad"} build_url:https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/GsqM5EoLTp6tlO0vMucCCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cca1f218d5aeb3548ef796f9f79fd2bb1e8893afb9eb71c96922529187c005795f60824e66a428dbc581c2ff80933d98ee0114f1b953f77307060d975a44b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30ed8e09d0f7ab32c2abbb8c870ae7144b52f4a65412f7cd78d889583eeadc89b1734db8693d80432131e07a2a5f2954df0f77cc50e149f00d1a2ff108600ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d9f0e60a03aa47c7505820348e1891aa522e978b7aed8bb1275dd21c155fe462d372b18c035e6fc7cfcf39fa7d7a2274d533b68df07b9a7e6150bbaf04447ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:41:18.684194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:41:18.684583) ========= 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=523ca41ca1e0623de333ad52000001bf-1476789629.380383-355545222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:41:18.770385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:41:18.771155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:41:18.771709) ========= ========= Total master_lag: 0.16 =========