builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1480261062.0 results: success (0) buildid: 20161127062319 builduid: 4a9408e966b9482da542518126cbe788 revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:41.997431) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:41.998009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:41.998365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:42.016940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:42.017315) ========= 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=db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-27 07:37:43-- 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% 50.7M=0s 2016-11-27 07:37:43 (50.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092305 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:42.124017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:42.124414) ========= 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=db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013308 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:42.175035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 07:37:42.175503) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --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=db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-27 07:37:43,520 truncating revision to first 12 chars 2016-11-27 07:37:43,520 Setting DEBUG logging. 2016-11-27 07:37:43,520 attempt 1/10 2016-11-27 07:37:43,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05328d3102ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 07:37:44,243 unpacking tar archive at: mozilla-central-05328d3102ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036985 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 07:37:43.225953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:43.226267) ========= script_repo_revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:43.226715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:43.227054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 07:37:43.239906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-27 07:37:43.240210) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:44 INFO - MultiFileLogger online at 20161127 07:37:44 in /builds/slave/test 07:37:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:37:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:44 INFO - {'append_to_log': False, 07:37:44 INFO - 'base_work_dir': '/builds/slave/test', 07:37:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:37:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:44 INFO - 'branch': 'Firefox-Non-PGO', 07:37:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:44 INFO - 'config_files': ('talos/linux_config.py',), 07:37:44 INFO - 'default_actions': ('clobber', 07:37:44 INFO - 'read-buildbot-config', 07:37:44 INFO - 'download-and-extract', 07:37:44 INFO - 'populate-webroot', 07:37:44 INFO - 'create-virtualenv', 07:37:44 INFO - 'install', 07:37:44 INFO - 'run-tests'), 07:37:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:44 INFO - 'download_minidump_stackwalk': True, 07:37:44 INFO - 'download_symbols': 'ondemand', 07:37:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:44 INFO - 'installer_path': 'installer.exe', 07:37:44 INFO - 'log_level': 'info', 07:37:44 INFO - 'log_name': 'talos', 07:37:44 INFO - 'log_to_console': True, 07:37:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:44 INFO - 'opt_config_files': (), 07:37:44 INFO - 'pip_index': False, 07:37:44 INFO - 'sps_profile': False, 07:37:44 INFO - 'sps_profile_interval': 0, 07:37:44 INFO - 'suite': 'dromaeojs', 07:37:44 INFO - 'system_bits': '32', 07:37:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:44 INFO - 'title': 'talos-linux64-ix-049', 07:37:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:44 INFO - 'use_talos_json': True, 07:37:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:44 INFO - 'work_dir': 'build'} 07:37:44 INFO - [mozharness: 2016-11-27 15:37:44.685673Z] Running clobber step. 07:37:44 INFO - Running pre-action listener: _resource_record_pre_action 07:37:44 INFO - Running main action method: clobber 07:37:44 INFO - rmtree: /builds/slave/test/build 07:37:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:45 INFO - Running post-action listener: _resource_record_post_action 07:37:45 INFO - [mozharness: 2016-11-27 15:37:45.146142Z] Finished clobber step (success) 07:37:45 INFO - [mozharness: 2016-11-27 15:37:45.146240Z] Running read-buildbot-config step. 07:37:45 INFO - Running pre-action listener: _resource_record_pre_action 07:37:45 INFO - Running main action method: read_buildbot_config 07:37:45 INFO - Using buildbot properties: 07:37:45 INFO - { 07:37:45 INFO - "project": "", 07:37:45 INFO - "product": "firefox", 07:37:45 INFO - "script_repo_revision": "production", 07:37:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:37:45 INFO - "repository": "", 07:37:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:37:45 INFO - "buildid": "20161127062319", 07:37:45 INFO - "pgo_build": "False", 07:37:45 INFO - "basedir": "/builds/slave/test", 07:37:45 INFO - "buildnumber": 838, 07:37:45 INFO - "slavename": "talos-linux64-ix-049", 07:37:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:37:45 INFO - "platform": "ubuntu64_hw", 07:37:45 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:37:45 INFO - "branch": "mozilla-central", 07:37:45 INFO - "repo_path": "mozilla-central", 07:37:45 INFO - "revision": "05328d3102efd4d5fc0696489734d7771d24459f", 07:37:45 INFO - "stage_platform": "linux64", 07:37:45 INFO - "builduid": "4a9408e966b9482da542518126cbe788", 07:37:45 INFO - "slavebuilddir": "test" 07:37:45 INFO - } 07:37:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:37:45 INFO - Running post-action listener: _resource_record_post_action 07:37:45 INFO - [mozharness: 2016-11-27 15:37:45.148643Z] Finished read-buildbot-config step (success) 07:37:45 INFO - [mozharness: 2016-11-27 15:37:45.148731Z] Running download-and-extract step. 07:37:45 INFO - Running pre-action listener: _resource_record_pre_action 07:37:45 INFO - Running main action method: download_and_extract 07:37:45 INFO - mkdir: /builds/slave/test/build/tests 07:37: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')]} 07:37:45 INFO - trying https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:37:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:45 INFO - Downloaded 1361 bytes. 07:37:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:37:45 INFO - Using the following test package requirements: 07:37:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'jsshell-linux-x86_64.zip'], 07:37:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:37:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:45 INFO - Fetch https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:46 INFO - Http code: 200 07:37:46 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 07:37:46 INFO - x-amz-cf-id: thSOBb1vBvH00Zm74ub-qp_SmAqgogjsVF_mm5mR7rHSoHahByAk4g== 07:37:46 INFO - x-amz-version-id: wATAmLa1qiXrVStFc8Ie4kAmhChNOYMS 07:37:46 INFO - Expected file size: 20217461 07:37:46 INFO - Obtained file size: 20217461 07:37:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:37:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:50 INFO - Fetch https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:51 INFO - Http code: 200 07:37:51 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 07:37:51 INFO - x-amz-cf-id: tOP9BNy4g1bM6DUCDrC4joVE-7RAwi8nUTrPom50IbmmVeJ08s6pGA== 07:37:51 INFO - x-amz-version-id: wATAmLa1qiXrVStFc8Ie4kAmhChNOYMS 07:37:51 INFO - Expected file size: 20217461 07:37:51 INFO - Obtained file size: 20217461 07:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:37:56 INFO - Http code: 200 07:37:56 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 07:37:56 INFO - x-amz-cf-id: X7P0MSMP8MKQOHZfDj16aFhVTyACyUj6wGB_tzDKpPhKtoCENc_76w== 07:37:56 INFO - x-amz-version-id: 1GQurA6wkgTwVJBoRv3Hibtdf82Ac5sY 07:37:56 INFO - Expected file size: 14409702 07:37:56 INFO - Obtained file size: 14409702 07:37:56 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')]} 07:37:56 INFO - trying https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:58 INFO - Downloaded 55671450 bytes. 07:37:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:58 INFO - mkdir: /builds/slave/test/properties 07:37:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:58 INFO - Contents: 07:37:58 INFO - build_url:https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:59 INFO - Running post-action listener: _resource_record_post_action 07:37:59 INFO - Running post-action listener: set_extra_try_arguments 07:37:59 INFO - [mozharness: 2016-11-27 15:37:59.180475Z] Finished download-and-extract step (success) 07:37:59 INFO - [mozharness: 2016-11-27 15:37:59.180701Z] Running populate-webroot step. 07:37:59 INFO - Running pre-action listener: _resource_record_pre_action 07:37:59 INFO - Running main action method: populate_webroot 07:37:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:59 INFO - '--tppagecycles', 07:37:59 INFO - '7'], 07:37:59 INFO - 'tests': ['tsvgm']}}, 07:37:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['damp', 'tps']}, 07:37:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'tests': ['damp', 'tps']}, 07:37:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['dromaeo_dom']}, 07:37:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['basic_compositor_video']}, 07:37:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['a11yr', 07:37:59 INFO - 'ts_paint', 07:37:59 INFO - 'tpaint', 07:37:59 INFO - 'sessionrestore', 07:37:59 INFO - 'sessionrestore_no_auto_restore', 07:37:59 INFO - 'tabpaint']}, 07:37:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:59 INFO - 'ts_paint', 07:37:59 INFO - 'tpaint', 07:37:59 INFO - 'sessionrestore', 07:37:59 INFO - 'sessionrestore_no_auto_restore', 07:37:59 INFO - 'tabpaint']}, 07:37:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:59 INFO - 'ts_paint', 07:37:59 INFO - 'tpaint', 07:37:59 INFO - 'sessionrestore', 07:37:59 INFO - 'sessionrestore_no_auto_restore', 07:37:59 INFO - 'tabpaint']}, 07:37:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:59 INFO - 'ts_paint', 07:37:59 INFO - 'tpaint', 07:37:59 INFO - 'sessionrestore', 07:37:59 INFO - 'sessionrestore_no_auto_restore', 07:37:59 INFO - 'tabpaint']}, 07:37:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['a11yr', 07:37:59 INFO - 'ts_paint', 07:37:59 INFO - 'tpaint', 07:37:59 INFO - 'sessionrestore', 07:37:59 INFO - 'sessionrestore_no_auto_restore', 07:37:59 INFO - 'tabpaint']}, 07:37:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['a11yr', 07:37:59 INFO - 'ts_paint', 07:37:59 INFO - 'tpaint', 07:37:59 INFO - 'sessionrestore', 07:37:59 INFO - 'sessionrestore_no_auto_restore', 07:37:59 INFO - 'tabpaint']}, 07:37:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['tsvgx', 07:37:59 INFO - 'tsvgr_opacity', 07:37:59 INFO - 'tart', 07:37:59 INFO - 'tscrollx', 07:37:59 INFO - 'cart', 07:37:59 INFO - 'tsvg_static']}, 07:37:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:59 INFO - 'tsvgr_opacity', 07:37:59 INFO - 'tart', 07:37:59 INFO - 'tscrollx', 07:37:59 INFO - 'cart', 07:37:59 INFO - 'tsvg_static']}, 07:37:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'talos_options': ['--disable-e10s'], 07:37:59 INFO - 'tests': ['tp5o']}, 07:37:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:37:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'talos_options': ['--disable-e10s', 07:37:59 INFO - '--xperf_path', 07:37:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:59 INFO - 'tests': ['tp5n']}, 07:37:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:37:59 INFO - 'talos_options': ['--xperf_path', 07:37:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:59 INFO - 'tests': ['tp5n']}}, 07:37:59 INFO - 'talos.zip': {'path': '', 07:37:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:59 INFO - Running post-action listener: _resource_record_post_action 07:37:59 INFO - [mozharness: 2016-11-27 15:37:59.201776Z] Finished populate-webroot step (success) 07:37:59 INFO - [mozharness: 2016-11-27 15:37:59.201864Z] Running create-virtualenv step. 07:37:59 INFO - Running pre-action listener: _resource_record_pre_action 07:37:59 INFO - Running main action method: create_virtualenv 07:37:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:59 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 07:37:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:59 INFO - Using real prefix '/usr' 07:37:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:01 INFO - Installing pip.................done. 07:38:01 INFO - Return code: 0 07:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:01 INFO - Reading from file tmpfile_stdout 07:38:01 INFO - Output received: 07:38:01 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) 07:38:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:02 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:02 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 07:38:02 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 07:38:02 INFO - Using env: {'DISPLAY': ':0', 07:38:02 INFO - 'HOME': '/home/cltbld', 07:38:02 INFO - 'LANG': 'en_US.UTF-8', 07:38:02 INFO - 'LANGUAGE': 'en_US:en', 07:38:02 INFO - 'LOGNAME': 'cltbld', 07:38:02 INFO - 'MAIL': '/var/mail/cltbld', 07:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:02 INFO - 'MOZ_NO_REMOTE': '1', 07:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:02 INFO - 'NO_EM_RESTART': '1', 07:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:02 INFO - 'PWD': '/builds/slave/test', 07:38:02 INFO - 'SHELL': '/bin/bash', 07:38:02 INFO - 'SHLVL': '1', 07:38:02 INFO - 'TERM': 'linux', 07:38:02 INFO - 'TMOUT': '86400', 07:38:02 INFO - 'USER': 'cltbld', 07:38:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:02 INFO - '_': '/tools/buildbot/bin/python'} 07:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:02 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 07:38:02 INFO - Cleaning up... 07:38:02 INFO - Return code: 0 07:38:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:02 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')]} 07:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:02 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')]} 07:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:02 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:02 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 07:38:02 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 07:38:02 INFO - Using env: {'DISPLAY': ':0', 07:38:02 INFO - 'HOME': '/home/cltbld', 07:38:02 INFO - 'LANG': 'en_US.UTF-8', 07:38:02 INFO - 'LANGUAGE': 'en_US:en', 07:38:02 INFO - 'LOGNAME': 'cltbld', 07:38:02 INFO - 'MAIL': '/var/mail/cltbld', 07:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:02 INFO - 'MOZ_NO_REMOTE': '1', 07:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:02 INFO - 'NO_EM_RESTART': '1', 07:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:02 INFO - 'PWD': '/builds/slave/test', 07:38:02 INFO - 'SHELL': '/bin/bash', 07:38:02 INFO - 'SHLVL': '1', 07:38:02 INFO - 'TERM': 'linux', 07:38:02 INFO - 'TMOUT': '86400', 07:38:02 INFO - 'USER': 'cltbld', 07:38:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:02 INFO - '_': '/tools/buildbot/bin/python'} 07:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:02 INFO - Downloading/unpacking psutil>=3.1.1 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 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 07:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:04 INFO - Installing collected packages: psutil 07:38:04 INFO - Running setup.py install for psutil 07:38:04 INFO - building 'psutil._psutil_linux' extension 07:38:04 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 07:38:04 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 07:38:04 INFO - building 'psutil._psutil_posix' extension 07:38:04 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 07:38:04 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 07:38:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:04 INFO - Successfully installed psutil 07:38:04 INFO - Cleaning up... 07:38:05 INFO - Return code: 0 07:38:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:05 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')]} 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:05 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')]} 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:05 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:05 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 07:38:05 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 07:38:05 INFO - Using env: {'DISPLAY': ':0', 07:38:05 INFO - 'HOME': '/home/cltbld', 07:38:05 INFO - 'LANG': 'en_US.UTF-8', 07:38:05 INFO - 'LANGUAGE': 'en_US:en', 07:38:05 INFO - 'LOGNAME': 'cltbld', 07:38:05 INFO - 'MAIL': '/var/mail/cltbld', 07:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:05 INFO - 'MOZ_NO_REMOTE': '1', 07:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:05 INFO - 'NO_EM_RESTART': '1', 07:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:05 INFO - 'PWD': '/builds/slave/test', 07:38:05 INFO - 'SHELL': '/bin/bash', 07:38:05 INFO - 'SHLVL': '1', 07:38:05 INFO - 'TERM': 'linux', 07:38:05 INFO - 'TMOUT': '86400', 07:38:05 INFO - 'USER': 'cltbld', 07:38:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:05 INFO - '_': '/tools/buildbot/bin/python'} 07:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:05 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 07:38:05 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 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:07 INFO - Installing collected packages: mozsystemmonitor 07:38:07 INFO - Running setup.py install for mozsystemmonitor 07:38:07 INFO - Successfully installed mozsystemmonitor 07:38:07 INFO - Cleaning up... 07:38:07 INFO - Return code: 0 07:38:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:07 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')]} 07:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:07 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')]} 07:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:07 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 07:38:07 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 07:38:07 INFO - Using env: {'DISPLAY': ':0', 07:38:07 INFO - 'HOME': '/home/cltbld', 07:38:07 INFO - 'LANG': 'en_US.UTF-8', 07:38:07 INFO - 'LANGUAGE': 'en_US:en', 07:38:07 INFO - 'LOGNAME': 'cltbld', 07:38:07 INFO - 'MAIL': '/var/mail/cltbld', 07:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:07 INFO - 'MOZ_NO_REMOTE': '1', 07:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:07 INFO - 'NO_EM_RESTART': '1', 07:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:07 INFO - 'PWD': '/builds/slave/test', 07:38:07 INFO - 'SHELL': '/bin/bash', 07:38:07 INFO - 'SHLVL': '1', 07:38:07 INFO - 'TERM': 'linux', 07:38:07 INFO - 'TMOUT': '86400', 07:38:07 INFO - 'USER': 'cltbld', 07:38:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:07 INFO - '_': '/tools/buildbot/bin/python'} 07:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:07 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:09 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 07:38:09 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 07:38:09 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 07:38:09 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 07:38:09 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 07:38:09 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 07:38:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:09 INFO - warning: no files found matching '*.txt' 07:38:09 INFO - no previously-included directories found matching 'build' 07:38:09 INFO - no previously-included directories found matching 'dist' 07:38:09 INFO - no previously-included directories found matching '.git*' 07:38:09 INFO - Installing collected packages: jsonschema, functools32 07:38:09 INFO - Running setup.py install for functools32 07:38:09 INFO - warning: no files found matching '*.txt' 07:38:09 INFO - no previously-included directories found matching 'build' 07:38:09 INFO - no previously-included directories found matching 'dist' 07:38:09 INFO - no previously-included directories found matching '.git*' 07:38:10 INFO - Successfully installed jsonschema functools32 07:38:10 INFO - Cleaning up... 07:38:10 INFO - Return code: 0 07:38:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:10 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:10 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 07:38:10 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 07:38:10 INFO - Using env: {'DISPLAY': ':0', 07:38:10 INFO - 'HOME': '/home/cltbld', 07:38:10 INFO - 'LANG': 'en_US.UTF-8', 07:38:10 INFO - 'LANGUAGE': 'en_US:en', 07:38:10 INFO - 'LOGNAME': 'cltbld', 07:38:10 INFO - 'MAIL': '/var/mail/cltbld', 07:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:10 INFO - 'MOZ_NO_REMOTE': '1', 07:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:10 INFO - 'NO_EM_RESTART': '1', 07:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:10 INFO - 'PWD': '/builds/slave/test', 07:38:10 INFO - 'SHELL': '/bin/bash', 07:38:10 INFO - 'SHLVL': '1', 07:38:10 INFO - 'TERM': 'linux', 07:38:10 INFO - 'TMOUT': '86400', 07:38:10 INFO - 'USER': 'cltbld', 07:38:10 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:10 INFO - '_': '/tools/buildbot/bin/python'} 07:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:10 INFO - Cleaning up... 07:38:10 INFO - Return code: 0 07:38:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:10 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:10 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 07:38:10 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 07:38:10 INFO - Using env: {'DISPLAY': ':0', 07:38:10 INFO - 'HOME': '/home/cltbld', 07:38:10 INFO - 'LANG': 'en_US.UTF-8', 07:38:10 INFO - 'LANGUAGE': 'en_US:en', 07:38:10 INFO - 'LOGNAME': 'cltbld', 07:38:10 INFO - 'MAIL': '/var/mail/cltbld', 07:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:10 INFO - 'MOZ_NO_REMOTE': '1', 07:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:10 INFO - 'NO_EM_RESTART': '1', 07:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:10 INFO - 'PWD': '/builds/slave/test', 07:38:10 INFO - 'SHELL': '/bin/bash', 07:38:10 INFO - 'SHLVL': '1', 07:38:10 INFO - 'TERM': 'linux', 07:38:10 INFO - 'TMOUT': '86400', 07:38:10 INFO - 'USER': 'cltbld', 07:38:10 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:10 INFO - '_': '/tools/buildbot/bin/python'} 07:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:10 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:10 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 07:38:10 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 07:38:10 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 07:38:10 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 07:38:10 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 07:38:10 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 07:38:12 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:13 INFO - Downloading docopt-0.6.1.tar.gz 07:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:13 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:13 INFO - Running setup.py install for blobuploader 07:38:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:13 INFO - Running setup.py install for requests 07:38:13 INFO - Running setup.py install for docopt 07:38:13 INFO - Successfully installed blobuploader requests docopt 07:38:13 INFO - Cleaning up... 07:38:13 INFO - Return code: 0 07:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:13 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')]} 07:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:13 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')]} 07:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:13 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:13 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 07:38:13 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 07:38:13 INFO - Using env: {'DISPLAY': ':0', 07:38:13 INFO - 'HOME': '/home/cltbld', 07:38:13 INFO - 'LANG': 'en_US.UTF-8', 07:38:13 INFO - 'LANGUAGE': 'en_US:en', 07:38:13 INFO - 'LOGNAME': 'cltbld', 07:38:13 INFO - 'MAIL': '/var/mail/cltbld', 07:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:13 INFO - 'MOZ_NO_REMOTE': '1', 07:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:13 INFO - 'NO_EM_RESTART': '1', 07:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:13 INFO - 'PWD': '/builds/slave/test', 07:38:13 INFO - 'SHELL': '/bin/bash', 07:38:13 INFO - 'SHLVL': '1', 07:38:13 INFO - 'TERM': 'linux', 07:38:13 INFO - 'TMOUT': '86400', 07:38:13 INFO - 'USER': 'cltbld', 07:38:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:13 INFO - '_': '/tools/buildbot/bin/python'} 07:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:14 INFO - Running setup.py (path:/tmp/pip-m8OsfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:14 INFO - Running setup.py (path:/tmp/pip-IOzxmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:14 INFO - Running setup.py (path:/tmp/pip-fLE0IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:14 INFO - Running setup.py (path:/tmp/pip-da8AMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:14 INFO - Running setup.py (path:/tmp/pip-oMt6Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:14 INFO - Running setup.py (path:/tmp/pip-dHkmjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:14 INFO - Running setup.py (path:/tmp/pip-SFnymZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:14 INFO - Running setup.py (path:/tmp/pip-MNLZvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:14 INFO - Running setup.py (path:/tmp/pip-Qt40vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:14 INFO - Running setup.py (path:/tmp/pip-86fgLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:14 INFO - Running setup.py (path:/tmp/pip-0QAkqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:14 INFO - Running setup.py (path:/tmp/pip-rElMX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:14 INFO - Running setup.py (path:/tmp/pip-g9MGC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:15 INFO - Running setup.py (path:/tmp/pip-r4dL1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:15 INFO - Running setup.py (path:/tmp/pip-fTVDBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:15 INFO - Running setup.py (path:/tmp/pip-R4OIqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:15 INFO - Running setup.py (path:/tmp/pip-eBqeuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:15 INFO - Running setup.py install for manifestparser 07:38:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozcrash 07:38:15 INFO - Running setup.py install for mozdebug 07:38:15 INFO - Running setup.py install for mozdevice 07:38:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozfile 07:38:15 INFO - Running setup.py install for mozhttpd 07:38:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozinfo 07:38:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for mozInstall 07:38:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for mozleak 07:38:16 INFO - Running setup.py install for mozlog 07:38:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for moznetwork 07:38:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for mozprocess 07:38:16 INFO - Running setup.py install for mozprofile 07:38:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for mozrunner 07:38:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for mozscreenshot 07:38:16 INFO - Running setup.py install for moztest 07:38:17 INFO - Running setup.py install for mozversion 07:38:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:17 INFO - Cleaning up... 07:38:17 INFO - Return code: 0 07:38:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:17 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')]} 07:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:17 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')]} 07:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:17 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:17 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 07:38:17 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 07:38:17 INFO - Using env: {'DISPLAY': ':0', 07:38:17 INFO - 'HOME': '/home/cltbld', 07:38:17 INFO - 'LANG': 'en_US.UTF-8', 07:38:17 INFO - 'LANGUAGE': 'en_US:en', 07:38:17 INFO - 'LOGNAME': 'cltbld', 07:38:17 INFO - 'MAIL': '/var/mail/cltbld', 07:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:17 INFO - 'MOZ_NO_REMOTE': '1', 07:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:17 INFO - 'NO_EM_RESTART': '1', 07:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:17 INFO - 'PWD': '/builds/slave/test', 07:38:17 INFO - 'SHELL': '/bin/bash', 07:38:17 INFO - 'SHLVL': '1', 07:38:17 INFO - 'TERM': 'linux', 07:38:17 INFO - 'TMOUT': '86400', 07:38:17 INFO - 'USER': 'cltbld', 07:38:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:17 INFO - '_': '/tools/buildbot/bin/python'} 07:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:17 INFO - Running setup.py (path:/tmp/pip-xdU9LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:17 INFO - Running setup.py (path:/tmp/pip-spaBs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:17 INFO - Running setup.py (path:/tmp/pip-3GTgnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:17 INFO - Running setup.py (path:/tmp/pip-Rbnzr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:17 INFO - Running setup.py (path:/tmp/pip-c0xwwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:17 INFO - Running setup.py (path:/tmp/pip-qcQcdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:17 INFO - Running setup.py (path:/tmp/pip-GYKNab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:17 INFO - Running setup.py (path:/tmp/pip-ChtJfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:17 INFO - Running setup.py (path:/tmp/pip-L8_Rbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:18 INFO - Running setup.py (path:/tmp/pip-hK4rrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:18 INFO - Running setup.py (path:/tmp/pip-IDkfnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:18 INFO - Running setup.py (path:/tmp/pip-O4OvEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:18 INFO - Running setup.py (path:/tmp/pip-V_RmON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:18 INFO - Running setup.py (path:/tmp/pip-3hfkhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:18 INFO - Running setup.py (path:/tmp/pip-dche3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:18 INFO - Running setup.py (path:/tmp/pip-Ae4TwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:18 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)) 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:18 INFO - Running setup.py (path:/tmp/pip-u4qYsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:18 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)) 07:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:18 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)) 07:38:18 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:18 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:18 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 07:38:18 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 07:38:18 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 07:38:18 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 07:38:18 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 07:38:18 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 07:38:20 INFO - Downloading blessings-1.6.tar.gz 07:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:20 INFO - Installing collected packages: blessings 07:38:20 INFO - Running setup.py install for blessings 07:38:20 INFO - Successfully installed blessings 07:38:20 INFO - Cleaning up... 07:38:20 INFO - Return code: 0 07:38:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:21 INFO - Reading from file tmpfile_stdout 07:38:21 INFO - Current package versions: 07:38:21 INFO - argparse == 1.2.1 07:38:21 INFO - blessings == 1.6 07:38:21 INFO - blobuploader == 1.2.4 07:38:21 INFO - docopt == 0.6.1 07:38:21 INFO - functools32 == 3.2.3-2 07:38:21 INFO - jsonschema == 2.5.1 07:38:21 INFO - manifestparser == 1.1 07:38:21 INFO - mozInstall == 1.12 07:38:21 INFO - mozcrash == 1.0 07:38:21 INFO - mozdebug == 0.1 07:38:21 INFO - mozdevice == 0.49 07:38:21 INFO - mozfile == 1.2 07:38:21 INFO - mozhttpd == 0.7 07:38:21 INFO - mozinfo == 0.9 07:38:21 INFO - mozleak == 0.1 07:38:21 INFO - mozlog == 3.4 07:38:21 INFO - moznetwork == 0.27 07:38:21 INFO - mozprocess == 0.23 07:38:21 INFO - mozprofile == 0.28 07:38:21 INFO - mozrunner == 6.13 07:38:21 INFO - mozscreenshot == 0.1 07:38:21 INFO - mozsystemmonitor == 0.3 07:38:21 INFO - moztest == 0.7 07:38:21 INFO - mozversion == 1.4 07:38:21 INFO - psutil == 3.1.1 07:38:21 INFO - requests == 1.2.3 07:38:21 INFO - wsgiref == 0.1.2 07:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:21 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')]} 07:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:21 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')]} 07:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:21 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:21 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 07:38:21 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 07:38:21 INFO - Using env: {'DISPLAY': ':0', 07:38:21 INFO - 'HOME': '/home/cltbld', 07:38:21 INFO - 'LANG': 'en_US.UTF-8', 07:38:21 INFO - 'LANGUAGE': 'en_US:en', 07:38:21 INFO - 'LOGNAME': 'cltbld', 07:38:21 INFO - 'MAIL': '/var/mail/cltbld', 07:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:21 INFO - 'MOZ_NO_REMOTE': '1', 07:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:21 INFO - 'NO_EM_RESTART': '1', 07:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:21 INFO - 'PWD': '/builds/slave/test', 07:38:21 INFO - 'SHELL': '/bin/bash', 07:38:21 INFO - 'SHLVL': '1', 07:38:21 INFO - 'TERM': 'linux', 07:38:21 INFO - 'TMOUT': '86400', 07:38:21 INFO - 'USER': 'cltbld', 07:38:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:21 INFO - '_': '/tools/buildbot/bin/python'} 07:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 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)) 07:38:21 INFO - Cleaning up... 07:38:21 INFO - Return code: 0 07:38:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:21 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')]} 07:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:21 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')]} 07:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:21 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 0x7fe0f6247e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', '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 07:38:21 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 07:38:21 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 07:38:21 INFO - Using env: {'DISPLAY': ':0', 07:38:21 INFO - 'HOME': '/home/cltbld', 07:38:21 INFO - 'LANG': 'en_US.UTF-8', 07:38:21 INFO - 'LANGUAGE': 'en_US:en', 07:38:21 INFO - 'LOGNAME': 'cltbld', 07:38:21 INFO - 'MAIL': '/var/mail/cltbld', 07:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:21 INFO - 'MOZ_NO_REMOTE': '1', 07:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:21 INFO - 'NO_EM_RESTART': '1', 07:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:21 INFO - 'PWD': '/builds/slave/test', 07:38:21 INFO - 'SHELL': '/bin/bash', 07:38:21 INFO - 'SHLVL': '1', 07:38:21 INFO - 'TERM': 'linux', 07:38:21 INFO - 'TMOUT': '86400', 07:38:21 INFO - 'USER': 'cltbld', 07:38:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:21 INFO - '_': '/tools/buildbot/bin/python'} 07:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:21 INFO - Cleaning up... 07:38:21 INFO - Return code: 0 07:38:21 INFO - Running post-action listener: _resource_record_post_action 07:38:21 INFO - Running post-action listener: _start_resource_monitoring 07:38:21 INFO - Starting resource monitoring. 07:38:21 INFO - [mozharness: 2016-11-27 15:38:21.506052Z] Finished create-virtualenv step (success) 07:38:21 INFO - [mozharness: 2016-11-27 15:38:21.506591Z] Running install step. 07:38:21 INFO - Running pre-action listener: _resource_record_pre_action 07:38:21 INFO - Running main action method: install 07:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:21 INFO - Reading from file tmpfile_stdout 07:38:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:21 INFO - Reading from file tmpfile_stdout 07:38:21 INFO - Output received: 07:38:21 INFO - Usage: mozinstall [options] installer 07:38:21 INFO - Options: 07:38:21 INFO - -h, --help show this help message and exit 07:38:21 INFO - -d DEST, --destination=DEST 07:38:21 INFO - Directory to install application into. [default: 07:38:21 INFO - "/builds/slave/test"] 07:38:21 INFO - --app=APP Application being installed. [default: firefox] 07:38:21 INFO - mkdir: /builds/slave/test/build/application 07:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:38:37 INFO - Reading from file tmpfile_stdout 07:38:37 INFO - Output received: 07:38:37 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:37 INFO - Running post-action listener: _resource_record_post_action 07:38:37 INFO - [mozharness: 2016-11-27 15:38:37.897542Z] Finished install step (success) 07:38:37 INFO - [mozharness: 2016-11-27 15:38:37.897784Z] Running run-tests step. 07:38:37 INFO - Running pre-action listener: _resource_record_pre_action 07:38:37 INFO - Running main action method: run_tests 07:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:37 INFO - Python 2.7.3 07:38:37 INFO - Return code: 0 07:38:37 INFO - grabbing minidump binary from tooltool 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:37 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 0xffdfc0>, '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 0xffeec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:37 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 07:38:37 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 07:38:37 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 07:38:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:37 INFO - Return code: 0 07:38:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 07:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 07:38:37 INFO - Using env: {'DISPLAY': ':0', 07:38:37 INFO - 'HOME': '/home/cltbld', 07:38:37 INFO - 'LANG': 'en_US.UTF-8', 07:38:37 INFO - 'LANGUAGE': 'en_US:en', 07:38:37 INFO - 'LOGNAME': 'cltbld', 07:38:37 INFO - 'MAIL': '/var/mail/cltbld', 07:38:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:37 INFO - 'MOZ_NO_REMOTE': '1', 07:38:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:37 INFO - 'NO_EM_RESTART': '1', 07:38:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:37 INFO - 'PWD': '/builds/slave/test', 07:38:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:37 INFO - 'SHELL': '/bin/bash', 07:38:37 INFO - 'SHLVL': '1', 07:38:37 INFO - 'TERM': 'linux', 07:38:37 INFO - 'TMOUT': '86400', 07:38:37 INFO - 'USER': 'cltbld', 07:38:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332', 07:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:37 INFO - '_': '/tools/buildbot/bin/python'} 07:38:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 07:38:38 INFO - mozversion application_buildid: 20161127062319 07:38:38 INFO - mozversion application_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 07:38:38 INFO - mozversion application_display_name: Nightly 07:38:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:38 INFO - mozversion application_name: Firefox 07:38:38 INFO - mozversion application_remotingname: firefox 07:38:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:38 INFO - mozversion application_vendor: Mozilla 07:38:38 INFO - mozversion application_version: 53.0a1 07:38:38 INFO - mozversion platform_buildid: 20161127062319 07:38:38 INFO - mozversion platform_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 07:38:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:38 INFO - mozversion platform_version: 53.0a1 07:38:38 INFO - using testdate: 1480261118 07:38:38 INFO - actual date: 1480261118 07:38:38 INFO - starting webserver on 'localhost:50261' 07:38:38 INFO - SUITE-START | Running 2 tests 07:38:38 INFO - TEST-START | dromaeo_css 07:38:38 INFO - operating with platform_type : linux_ 07:38:38 INFO - Initialising browser for dromaeo_css test... 07:38:38 INFO - TEST-INFO | started process 29636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6IJqVW/profile http://localhost:50261/getInfo.html) 07:38:42 INFO - PROCESS | 29636 | __metrics Screen width/height:1600/1200 07:38:42 INFO - PROCESS | 29636 | colorDepth:24 07:38:42 INFO - PROCESS | 29636 | Browser inner width/height: 1024/697 07:38:42 INFO - PROCESS | 29636 | __metrics 07:38:43 INFO - PROCESS | 29636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:43 INFO - PROCESS | 29636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:43 INFO - PROCESS | 29636 | console.error: PushService: 07:38:43 INFO - PROCESS | 29636 | stateChangeProcessEnqueue: Error transitioning state 07:38:43 INFO - PROCESS | 29636 | UnknownError 07:38:44 INFO - TEST-INFO | 29636: exit 0 07:38:44 INFO - Browser initialized. 07:38:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:44 INFO - TEST-INFO | started process 29718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6IJqVW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:56 INFO - PROCESS | 29718 | RSS: Main: 174821376 07:38:56 INFO - PROCESS | 29718 | 07:39:47 INFO - PROCESS | 29718 | 1480261187675 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] 07:42:01 INFO - PROCESS | 29718 | Cycle 1(1): loaded http://localhost:50261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50261/tests/dromaeo/cssquery-ext.html) 07:42:03 INFO - PROCESS | 29718 | RSS: Main: 330399744 07:42:03 INFO - PROCESS | 29718 | 07:45:06 INFO - PROCESS | 29718 | Cycle 1(1): loaded http://localhost:50261/tests/dromaeo/cssquery-ext.html (next: http://localhost:50261/tests/dromaeo/cssquery-jquery.html) 07:45:07 INFO - PROCESS | 29718 | RSS: Main: 287703040 07:45:07 INFO - PROCESS | 29718 | 07:48:09 INFO - PROCESS | 29718 | Cycle 1(1): loaded http://localhost:50261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50261/tests/dromaeo/cssquery-mootools.html) 07:48:09 INFO - PROCESS | 29718 | RSS: Main: 223047680 07:48:09 INFO - PROCESS | 29718 | 07:51:12 INFO - PROCESS | 29718 | Cycle 1(1): loaded http://localhost:50261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50261/tests/dromaeo/cssquery-prototype.html) 07:51:12 INFO - PROCESS | 29718 | RSS: Main: 225009664 07:51:12 INFO - PROCESS | 29718 | 07:54:16 INFO - PROCESS | 29718 | Cycle 1(1): loaded http://localhost:50261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50261/tests/dromaeo/cssquery-yui.html) 07:54:16 INFO - PROCESS | 29718 | RSS: Main: 225947648 07:54:16 INFO - PROCESS | 29718 | 07:57:19 INFO - PROCESS | 29718 | Cycle 1(1): loaded http://localhost:50261/tests/dromaeo/cssquery-yui.html (next: http://localhost:50261/tests/dromaeo/cssquery-dojo.html) 07:57:20 INFO - PROCESS | 29718 | RSS: Main: 317927424 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | __start_tp_report 07:57:20 INFO - PROCESS | 29718 | _x_x_mozilla_page_load 07:57:20 INFO - PROCESS | 29718 | _x_x_mozilla_page_load_details 07:57:20 INFO - PROCESS | 29718 | |i|pagename|runs| 07:57:20 INFO - PROCESS | 29718 | |0;dojo.html;2593.1313010141603;2619.777318927891;2640.0495821504255;2655.641488399067;2660.7073221945584;4539.228331183698;4591.517890621479;4641;4667.929981050287;4686.367340409044;4620.676552641316;4626.583607475327;4644.3730096436975;4705.741184234866;4776.068666610013;4238.321868501025;4260.978695106535;4302.612764851163;4336.588024137702;4401.119776044788;4201.369794530814;4265.402843601898;4288.506821715496;4317.481902171744;4360.825566977317;4187.685923555746;4219.810108545123;4277.165952639237;4324.870253892357;4363.258246098155;4266.4240327556;4278.957210427887;4292;4294.957050429487;4300.677449191323;4270.081932384553;4270.359446083081;4272.893177670552;4274.743515389056;4277.850275240352;4584.26651735724;4594.632429405639;4605.424321959722;4606.56237657422;4614.3770590970125;4891.828785992473;4915.655904086715;4934.25986102084;4944.35723355965;4944.406671199479;4911.631627627942;4943.876403089916;4968.726720030433;4985.651004429691;5043.924341134886;4649.930251046237;4668.299755036704;4685.929711054337;4687.55468230521;4708.4820669726305;5048.545630893237;5084.110280700863;5087.26234695967;5089.134847076006;5142.897142057138;4748.4539277982785;4766.165920963817;4895.216765317532;4899.191633380524;4943.8516844494725;4896.902061958741;4917.237828136645;4933.358663373739;4940.629452790983;5034.320366750515;4923.75381230937;4925.1381008324115;4928.48250933654;4933.87665308363;5001.199808030698;4935.111679897581;4940.1601727706375;4941.827036053721;4942.827001054946;4981.875453113628;4200.327947528381;4228.217779710763;4229.936550951738;4242.660587153082;4259.403683484315;3717.1450566369886;3717.386631205821;3743.2513497300647;3748.6251374862295;3758.1919887224376;4296.505901821268;4304.053108316165;4308.91382172361;4350.58669426404;4351.82592696295;4831.323614693945;4867.780949857265;4880.292357608127;4970.850874473699;4978.65149439543;4250.914981700349;4276.593723596254;4290.37789520524;4307.698461107692;4346.608805207483;4523.163214805271;4528.162289976299;4529.184746745617;4535.25168347219;4574.885627859264;4563.429571303587;4698.060387922361;4700.059988002345;4706.176419126571;4751.976240118846;4852.902941941071;4883.633727470525;4924.950750492592;4943.184374578154;4961.50384961501;4706.317583950239;4710.670253082389;4716.434027916534;4748;4770.546798054179;4902.63230257725;4905.828296009622;4906.018796240694;4908.190148625579;4947.1342515059005;4692.859214223578;4776.379070720784;4781.067691800205;4821.614270858393;4982.4768399317545;4710.7880145392855;4712.646551508582;4714.905701885875;4723.220668589644;4724.71651700899;4819.59033482158;4826.61387089025;4890.755462226945;4913.828016019565;4964.851054468371;4794.664373493822;4796.040791841715;4807.423109226916;4808.927866082082;4843.104025755247;4702.318163866152;4934.9753251233515;4939.357883475125;4946.0355230729665;4984.028114517634;4690.1792186366565;4732.645051621211;4753.263244197155;4776.785044673067;4826.758662066953 07:57:20 INFO - PROCESS | 29718 | |1;ext.html;535.9896594918578;538.4427117932939;549.2722143160311;551.6552154903186;557.6291765975626;28390.43219135616;31384.215394615145;31403;31422.214444638896;31470.05589832306;38755.22489550207;39722.404163937565;39943.20113597734;43433.34849977245;43460.78269608656;7413.36986356159;7531.397488200931;7535.698572057111;7540.17058123606;7544.0569928758905;7336.3397294243505;7513.39892808574;7594.658240379169;7599.924000760005;7605;7310.451716121285;9581.473018983954;9802.901970980305;9806.215502759762;10157.796844063114;9739.756506087333;9801.362911410806;9803.460809655466;9816.214702823792;9818.607255709763;9487.810243795155;9558.378705384128;9560.091791279818;9564.617415303379;9565.569549370295;35886.282274354366;36198.8190059048;36216.637833621855;36224.63775362239;36232.63767362345;3027.258321711173;3096;3176.22182565273;3427.091820667525;3454.4300190468543;27271.45457090867;27893.58159627607;28148.718512814816;28181.29546761327;28943.710562894314;3288.0629020729216;3306.9503957440656;3312.801231926092;3318.435865902802;3478.913027174341;238655;239309;239384;239966;240663.79668101724;49787.75106124446;50175.498245017814;50210.74894625504;50225.74887125614;50384;53902;53958.7302063495;53989;54055.72972135114;54064;13203.801942970864;13344.733105337838;13399.196048237138;13407.798883016763;13408.530701425403;10229.897701023043;10298.073173414428;10303.278770485995;10303.639372621923;10305.948470257601;13525.39135738894;13932.512362067278;14653.560393188221;15397.692046159014;15404.92297538505;5992.67040312787;6366.649834259068;6377.71300291488;6387.776427825004;6689.832754181087;761.6534476813148;866.5623859950684;887.2192470625808;944.7543638653999;1000.9299349045497;26053.348666283495;26747.19758407251;27148.1855544334;27322.45355092927;27355.726442735715;896.6547879066607;905.8324210021167;925.2597921662777;951.6050838901916;952.9475878826593;14147.64630884236;14472.493462728755;14509.492167774288;14740.484083057256;14778.556643300719;354577;357023;357181;358872;359814;41841.37237941433;42279.57720422818;46672;48009.5199048012;48138;1047.1675018360422;1109.9667009989876;1117.7410284610723;1136.0684238924168;1145.2155273637584;27438.451230974868;28423.715762842934;29318.41363172682;29323.85338073296;29628;41438;41881;41950.32198712017;42027.57972420237;42048.36927446152;316081;531476;540748;541928;542848;23866.52266954686;23869;24076.51846963086;24135.51728965446;24176.274711758677;40398.39402409025;40425;40707.796461017504;41599.7920010398;41870.16259674729;34801.30397391987;35188.296234075686;35592.64407355997;35700.46449303211;35937.46093808647;34679.65320346764;34690.30619387649;34881.825590871886;35359.292814144086;35378.292434151685;33917.15207119842;33987.4901876477;34477.482837757954;34799.30401392009;35304.64695353014;29914;31931.36137277288;32196.35607287888;32266.193345166557;32401.189970250933;24396.146134885195;24492.387690307885;24748.87625561933;25062.74937250604;25220.495590088463 07:57:20 INFO - PROCESS | 29718 | |2;jquery.html;332.7604125029979;338.7103182486391;365.7092611373958;367;377.8828563145425;12534.874651253485;13304.600861974144;15538.92230538847;16159.83840161598;17482.21330040148;16558.17209139544;16571.751423728652;16625;16783.664326713457;16852.578685532866;3596.6762991330775;4857.417109946802;4906.89053747455;5079.771410286546;5082.2376643503585;4908.165611845995;5039.6976181429045;5051.368578927634;5052.040112378655;5052.393712754456;4988.950110498903;5017.19724844025;5019.54824065834;5026.723530205837;5029.321041659366;4884.633652476061;5145.691258524501;5161.81933632321;5222.399424066243;5235.947640523584;4890;5064.493550644943;5071.366079240095;5071.670341427833;5072.82245121419;11194.888051119548;11464.94267528657;11468.19722619417;11472.655820325404;11481.885181148165;1797.272104797559;1866.831985121332;2021.555257843272;2181;2300.1604414388626;8299.29455996241;8485.1090635483;8724.302055835582;8819.250363719091;11698.2981021139;1677.932882684691;1711.9144042797811;1726.343989284064;1729.1008675488677;1749.5276275405697;66894.66552667254;68566.65716671434;68820.96768548476;69887.30112698859;70741;9356.157945784777;9515.524223788783;9547.140757331874;9740.805183896282;9891.802163956681;13343.866561334262;13390.062695611214;13412.664683382993;13429.798553021712;13438.462461501626;6607.669616519155;6760.749261386561;7033.1560212773775;7061.646917654097;7139.464540159405;6410.45511131559;6422.614643121335;6474.223093228843;6564.6389448580785;6620.205575330895;3979.6617287530885;4009.0578714002186;4069.491313585802;4207.431996680471;4214.683898707609;1529.2888806704937;1599.9920000399923;1624.3096683909291;1659.9087050212354;1702.4296860551854;599.6222379900722;764.7552783109352;768.5580791045171;802.5465611929242;810.4934415990007;16293;16786.83213167877;16847;16853.325866965428;17565.912170439067;786.1745167574024;788.9881651775228;791.3313250303485;802.0776107476332;830.6926437218148;8969.50667713282;9359.953200233955;9624.470654114091;9654.613815447303;9793.265505087147;364172;368505;371545;371811;372159;75709.62145189349;76631.61684191543;77433;78186.21813781903;78612;849.9405041647149;870.0951010948795;874.7244617945327;877.1886005444937;879.7536689726759;14712.926435367755;14966.401343946556;14983.77524337114;15138.394464221748;15709;36256.456153157196;36382.454263185544;36454.8177259112;36917.26165476622;38197.80901095477;48811.511884880696;48890.75554622204;48897.266541001205;49267.50732492773;49495;6782.1861376635115;6828;6865.450763938773;6941.861162776817;7122.323379278961;10226.744331391776;11518.25131366492;11569;11575.826362604399;11744.414504042186;7928.85031670393;9904.702858914245;10426.218033647658;10476.895231047896;10676.199285053497;10068.295219334575;10380.948095259475;10434;10686.25196236287;10986.395748233925;9977.351472154287;10185.287029907835;10552.788944221225;10746.731331716457;10847.349159050482;6243.219597550306;7209.855802884018;7367.447441441806;7407.629618518945;7434.405247580289;8216.46592971455;10098.646547370807;10405.531751071068;10772.353658780497;10964.122870170526 07:57:20 INFO - PROCESS | 29718 | |3;mootools.html;1277.5464710027936;1316.0853207021119;1327.2302064802416;1568.5451219146448;1573.3863793120686;6200.937990620098;6528.738850445977;6530.412262896339;6537.313582073879;6539.901901471481;5932.584719069667;6124.816255512342;6245.875082498347;6396.424321811036;6459.51553633477;1957.921683132673;1961.342950111707;1978.2087165133917;1987.602479504105;1988.145097608028;1946.523101840044;1965.0174912543728;1976.3082920977615;1992.292736078693;1998.2007197121195;1665.0842036879728;1716.3048965169064;1916.492129585661;1959.6374670685898;1980.8415326773895;1925.5282455798279;1941.5049162463622;1944.3777991042873;1945.863789534726;1946.124244090151;1949.7855235924037;1952.5509132899372;1959.980400195994;1968.9606207875906;1983.6429442700307;6542.116814230113;6596.109525214083;6610.305917878602;6618.437432818217;6683.6658167091455;3864.594217607139;3976.701747368959;3978.900527486807;3979.960200397988;3980.223856348013;2598.167702638612;2723.6459260296233;2757.931051723723;2769.62610047643;2777.722227777226;853.9530325832139;866.3502373220085;885.3050355470924;901.8782464367292;914.7575892388522;8732.8690069649;8757.25563327118;8763.16749908764;8764.342674299389;8782.209601135928;3603.765755225902;3648.3615367310613;3720.404735242348;3721.292954338667;3733.178700685845;7658.425618078666;7659.846803063908;7662.46362754613;7663.693452261959;7666.8083297918;4042.2319759245647;4048;4054.39184122384;4055;4055.8377664893665;3165.841707914595;3276.983615081957;3561.0919215599856;3667.9816600916824;3734.8506059757306;3070.5854709614364;3104.7826652134586;3244.626867910173;3247.9675203247666;3250.3011852451364;1036.8859425463193;1043.9425831579335;1046.858674079005;1051.6161601015574;1085.0831047764627;707.3845754193884;712.1952194020827;720.9855802883912;725.6190499987443;751.6429695894407;4375.431193944831;4411.713238639478;4428.645708343325;4440.711353761995;4512.81948722054;354.8030842882225;371.48734746050815;372.7465323579938;379.0996383588976;383.74097484198614;3125.6249250090136;3137.3568418474156;3139.21519620095;3162.22525481254;3166.857491412892;7325.12098548167;7748.263914928073;7849.01887264092;7871.448998570159;7871.763847084597;7798.699383681827;7818.92181078182;7822.687092516349;7824.84350313002;7830.765077047698;6016.578839481194;6175.660338681416;6177.722002509808;6270.623762574261;6386.648734319657;4500.252233893274;4530.682852200314;4568.954310456853;4595.333676616939;4704.247320428715;7120.252373500708;7147.213806481387;7166.964165179141;7167.068281123421;7199.856002879808;7062.858742825012;7200.747973820891;7204.279572042754;7206.099237595301;7218.602976836324;5218.791248350175;5635.830925072254;5802.593818432838;5815.011448053757;5817.069268917122;5755.424457554211;5978.312494063239;6211.9689401554515;6213.285472170577;6336.239651241881;5626.43735626434;5739.282589676291;5773.451522105393;5804.390538993345;5917.881642367042;5723.914141287801;5779.422057794187;5831.35855055935;5831.970840145772;5879.412058794086;5456.48163424474;5500.064988951808;5527;5537.501624853782;5601.355844077821;3878.340682083996;3917.334053210904;3959.4162335066203;3968.722189446711;4028.254772867029;3845.0964023453907;3892.746971446847;3898.7270891037356;3929.7052721045466;3937.3897045957924 07:57:20 INFO - PROCESS | 29718 | |4;prototype.html;270.24870859011946;271.116161314116;277.8971780441236;279.2070519723986;279.2488206723911;4685.25035994241;4816.518348165182;4853.126437241295;4886.218205087187;4908.582770464511;4605.240135377659;4696.389469368985;4724.220503616908;4741.786619602118;4744.833930812422;3547.8048707321086;3654.470101835232;3689.3912504436803;3697.7411581189326;3724.944125838115;3620.7870363428283;3705.74059815813;3756.361418558838;3760.9435858462143;3769.6795772359383;3696.9445458318146;3711.925761484769;3727.1054946812706;3727.9813600931957;3730.048837546422;3709.2396058808013;3717.6654101130894;3725.4353171667694;3731.309707704056;3784.129650180474;3136.466800643896;3289.6381398046196;3317.3862835375535;3323;3327.672327672328;4690.484046754854;4698.483166851644;4698.590422873124;4708.4349878014855;4719.905601887977;4268.55180206077;4278.957210427887;4282.8715138545585;4289.892752681177;4297.183535128347;4878.487758785312;5019.272205530214;5031.723255220962;5044.167712327461;5056.002878862865;3570.893173027926;3580.3197392495345;3598.208394153282;3600.5859326177565;3614.6625748473234;5201.921971170435;5212.478752124757;5217.921731174036;5227.307936412751;5237.973810130963;3599.2441587266444;3612.0066981580276;3612.837422316002;3638.7270954678506;3663.8717644882836;3554.4845997330244;3649.5073165122367;3673.3204357194004;3682.650148235913;3704.2776658551325;4191.392248124005;4191.8532851350055;4195.601417865298;4200.411942328015;4216.915661686749;4703.506131856106;4792.0895029944195;4852.951470485321;5017.93905717512;5035.96762663653;1234.0066246671336;1242.6147894152841;1244.7012716947868;1248.7440074784647;1249.3508568689424;837.8001428731145;854.4232642965973;863.3093525179831;865.8700395983302;868.6395146014333;4318.438602981592;4321.395004699281;4325.199838029975;4330.891727706769;4333.306670932636;4979.456368525769;5025.291400923704;5027.095122877917;5028.949710502921;5038.395392552917;4254.446921900133;4332.913341733148;4333.458317710286;4339.913201735948;4344.218040752632;2501.7873480753974;2658.5214661360756;2681.2492502099444;2683.409649877024;2711.227300219428;4741;4757.381540399726;4757.8096876125255;4765.404324459442;4771.570558649669;5064.227520367842;5131.281620573122;5136.717480538531;5145.614078944094;5158.329417175743;4592.839250626212;4906.797834530563;4908.748269191334;4921.26181072842;4946.491320147389;5210;5228.607854410859;5232.398274198364;5233.712145832016;5251.52736253739;4977.676451030671;5123.6157288202785;5136.30659860914;5154.639175257696;5175.14610089331;4951.801927922843;4962.578180854668;4969.055879382906;4977.751112444291;4979.228219625964;3583;3595.676389124991;3605.3690604144695;3617.439296908983;3622.565292164957;4992.72540010303;5243.187305967581;5252.791857872634;5256.421793602777;5261.342332208474;4709.788059537261;5035.345405097314;5058.241263810458;5064.645474816874;5071.568916642127;5031.245313203049;5047.7476126192805;5062.417821950376;5067;5068.873278168076;4822.638302127425;4944.233643785219;4950.851474455772;4967.453580106113;4972.552470277692;5086.287919691172;5110.693358398508;5115.872103197301;5117.462666419972;5117.616178786531;4969.850904472872;4970.62720295972;4979.4024717032735;4988.825391111293;5010.173321402073 07:57:20 INFO - PROCESS | 29718 | |5;yui.html;584.5473997117164;596.3887015808798;645.5513418174371;653.483747839207;660.9985871404823;12603.432845521951;13147.868521314784;13745;13873.445062197525;13946.302684865754;11071.612493562727;12991.675208119801;13141.342932853368;13194.07641465098;13216.867831321684;703.8592281543686;730.3135053050116;740.6963145110506;740.8333125046876;742.3207764895142;738.674983007475;739.3530660671885;740.1968863782802;740.4150720930486;740.6074780366388;778.105179044101;779.0884664942031;781.3436713160944;784.0630446616295;784.396015068397;777.261601478592;777.4014009212931;777.9299863012328;778.4978688745728;778.6846327237449;569.5443645083958;575.0913556580592;575.1573944171809;575.2119596153296;576.1473019930485;10967.50646220914;11138.665840024812;11140.108791296676;11171.050460710849;11179.161562882817;10544.947275263652;10753.784924301548;10971.780564388668;11340.206185567014;11688.649340519798;10269.537870795757;10306.072453479148;11229.887701123047;11249.718757031058;11253.887461125447;3209.6629853865243;3214.8553315100876;3230.7576931729977;3289.276359200972;3350.5811773528308;38999.610003899885;52561.47438525604;61979.99999999955;66455.3354466454;67056;9993.450360230112;10191.133753631024;10447.320924140058;10450.738731531772;10500.474976251156;18405;18426.262949481872;18436.98596577201;18595.442136735648;18611;4970.577500912463;5049.469805670426;6158.538109641795;6205.410486003822;6462.676866156673;3483.494893240466;3582.946255806165;3590.551181102362;3610.332088563624;3616.0959760059986;2610.8825102870414;2716.8641567921527;2736.7947403944786;2739.5068887600423;2748.5877118432395;459.7172738765702;465.97903094360834;467.4320700349092;475.950025247351;476.04077783266746;479.7553247843625;519.4182515582572;538.3714264350372;556.9498745112959;571.2716286734446;8015.078265999368;8057.59712014397;8370.372222083368;8422.915770842214;8575.313974881994;552.9004779139793;569.9772009119589;572.9229049387126;586.5454272938507;589.9557533185028;3992.7005474589523;4016.9196616068098;4067.898302542401;4106.117184805281;4115.1563929395;70231.2976870235;72137;72171.63914180396;74476.62761686157;74523;61362.38637613656;62742;62782;63973.36026639674;64891;43881.12237755227;55784.72107639436;57133.71433142808;59178.40821591729;60248;7836.216378362118;8025.919740802751;8108.566412640232;8166.959165204136;8311.584420779058;38602.80698596489;39257;39716.60283397244;40472.59527404806;40673.593264068164;51688.74155629198;53850;54078;54493.18260226179;54815.17777233265;9093.863592046257;9188.310876684141;9231.861522077308;9344.813103737752;9350.625974960925;10951.671449856518;11139.33164010162;11302.660920172408;11365.204435689422;11718.531258749554;10584.417857017937;10696.786064278514;10720.410377429316;10905.291156074829;11375.919287667659;10423.374597524173;10654.62708805188;10895.291806032583;10928;11108.777824443627;10097.848532272168;10225.284230103822;10420.947895260475;10511.842322365324;11000.339979601249;8844.646214151362;9067.093290671144;9119.772005699911;9257.67598134062;9366.718998430058;8232.547209903274;8655.653773848975;8803.955980220058;8909.1536304051;9017.098290171192 07:57:20 INFO - PROCESS | 29718 | __end_tp_report 07:57:20 INFO - PROCESS | 29718 | __start_cc_report 07:57:20 INFO - PROCESS | 29718 | _x_x_mozilla_cycle_collect,1617 07:57:20 INFO - PROCESS | 29718 | __end_cc_report 07:57:20 INFO - PROCESS | 29718 | __startTimestamp1480262240177__endTimestamp 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | ------- Summary: start ------- 07:57:20 INFO - PROCESS | 29718 | Number of tests: 6 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | [#0] dojo.html Cycles:165 Average:4589.90 Median:4710.67 stddev:462.24 (9.8%) stddev-sans-first:436.31 07:57:20 INFO - PROCESS | 29718 | Values: 2593.1 2619.8 2640.0 2655.6 2660.7 4539.2 4591.5 4641.0 4667.9 4686.4 4620.7 4626.6 4644.4 4705.7 4776.1 4238.3 4261.0 4302.6 4336.6 4401.1 4201.4 4265.4 4288.5 4317.5 4360.8 4187.7 4219.8 4277.2 4324.9 4363.3 4266.4 4279.0 4292.0 4295.0 4300.7 4270.1 4270.4 4272.9 4274.7 4277.9 4584.3 4594.6 4605.4 4606.6 4614.4 4891.8 4915.7 4934.3 4944.4 4944.4 4911.6 4943.9 4968.7 4985.7 5043.9 4649.9 4668.3 4685.9 4687.6 4708.5 5048.5 5084.1 5087.3 5089.1 5142.9 4748.5 4766.2 4895.2 4899.2 4943.9 4896.9 4917.2 4933.4 4940.6 5034.3 4923.8 4925.1 4928.5 4933.9 5001.2 4935.1 4940.2 4941.8 4942.8 4981.9 4200.3 4228.2 4229.9 4242.7 4259.4 3717.1 3717.4 3743.3 3748.6 3758.2 4296.5 4304.1 4308.9 4350.6 4351.8 4831.3 4867.8 4880.3 4970.9 4978.7 4250.9 4276.6 4290.4 4307.7 4346.6 4523.2 4528.2 4529.2 4535.3 4574.9 4563.4 4698.1 4700.1 4706.2 4752.0 4852.9 4883.6 4925.0 4943.2 4961.5 4706.3 4710.7 4716.4 4748.0 4770.5 4902.6 4905.8 4906.0 4908.2 4947.1 4692.9 4776.4 4781.1 4821.6 4982.5 4710.8 4712.6 4714.9 4723.2 4724.7 4819.6 4826.6 4890.8 4913.8 4964.9 4794.7 4796.0 4807.4 4808.9 4843.1 4702.3 4935.0 4939.4 4946.0 4984.0 4690.2 4732.6 4753.3 4776.8 4826.8 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | [#1] ext.html Cycles:180 Average:50398.87 Median:195084.82 stddev:101752.99 (52.2%) stddev-sans-first:101969.57 07:57:20 INFO - PROCESS | 29718 | Values: 536.0 538.4 549.3 551.7 557.6 28390.4 31384.2 31403.0 31422.2 31470.1 38755.2 39722.4 39943.2 43433.3 43460.8 7413.4 7531.4 7535.7 7540.2 7544.1 7336.3 7513.4 7594.7 7599.9 7605.0 7310.5 9581.5 9802.9 9806.2 10157.8 9739.8 9801.4 9803.5 9816.2 9818.6 9487.8 9558.4 9560.1 9564.6 9565.6 35886.3 36198.8 36216.6 36224.6 36232.6 3027.3 3096.0 3176.2 3427.1 3454.4 27271.5 27893.6 28148.7 28181.3 28943.7 3288.1 3307.0 3312.8 3318.4 3478.9 238655.0 239309.0 239384.0 239966.0 240663.8 49787.8 50175.5 50210.7 50225.7 50384.0 53902.0 53958.7 53989.0 54055.7 54064.0 13203.8 13344.7 13399.2 13407.8 13408.5 10229.9 10298.1 10303.3 10303.6 10305.9 13525.4 13932.5 14653.6 15397.7 15404.9 5992.7 6366.6 6377.7 6387.8 6689.8 761.7 866.6 887.2 944.8 1000.9 26053.3 26747.2 27148.2 27322.5 27355.7 896.7 905.8 925.3 951.6 952.9 14147.6 14472.5 14509.5 14740.5 14778.6 354577.0 357023.0 357181.0 358872.0 359814.0 41841.4 42279.6 46672.0 48009.5 48138.0 1047.2 1110.0 1117.7 1136.1 1145.2 27438.5 28423.7 29318.4 29323.9 29628.0 41438.0 41881.0 41950.3 42027.6 42048.4 316081.0 531476.0 540748.0 541928.0 542848.0 23866.5 23869.0 24076.5 24135.5 24176.3 40398.4 40425.0 40707.8 41599.8 41870.2 34801.3 35188.3 35592.6 35700.5 35937.5 34679.7 34690.3 34881.8 35359.3 35378.3 33917.2 33987.5 34477.5 34799.3 35304.6 29914.0 31931.4 32196.4 32266.2 32401.2 24396.1 24492.4 24748.9 25062.7 25220.5 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | [#2] jquery.html Cycles:180 Average:23208.47 Median:26887.69 stddev:61236.42 (227.7%) stddev-sans-first:61384.12 07:57:20 INFO - PROCESS | 29718 | Values: 332.8 338.7 365.7 367.0 377.9 12534.9 13304.6 15538.9 16159.8 17482.2 16558.2 16571.8 16625.0 16783.7 16852.6 3596.7 4857.4 4906.9 5079.8 5082.2 4908.2 5039.7 5051.4 5052.0 5052.4 4989.0 5017.2 5019.5 5026.7 5029.3 4884.6 5145.7 5161.8 5222.4 5235.9 4890.0 5064.5 5071.4 5071.7 5072.8 11194.9 11464.9 11468.2 11472.7 11481.9 1797.3 1866.8 2021.6 2181.0 2300.2 8299.3 8485.1 8724.3 8819.3 11698.3 1677.9 1711.9 1726.3 1729.1 1749.5 66894.7 68566.7 68821.0 69887.3 70741.0 9356.2 9515.5 9547.1 9740.8 9891.8 13343.9 13390.1 13412.7 13429.8 13438.5 6607.7 6760.7 7033.2 7061.6 7139.5 6410.5 6422.6 6474.2 6564.6 6620.2 3979.7 4009.1 4069.5 4207.4 4214.7 1529.3 1600.0 1624.3 1659.9 1702.4 599.6 764.8 768.6 802.5 810.5 16293.0 16786.8 16847.0 16853.3 17565.9 786.2 789.0 791.3 802.1 830.7 8969.5 9360.0 9624.5 9654.6 9793.3 364172.0 368505.0 371545.0 371811.0 372159.0 75709.6 76631.6 77433.0 78186.2 78612.0 849.9 870.1 874.7 877.2 879.8 14712.9 14966.4 14983.8 15138.4 15709.0 36256.5 36382.5 36454.8 36917.3 38197.8 48811.5 48890.8 48897.3 49267.5 49495.0 6782.2 6828.0 6865.5 6941.9 7122.3 10226.7 11518.3 11569.0 11575.8 11744.4 7928.9 9904.7 10426.2 10476.9 10676.2 10068.3 10380.9 10434.0 10686.3 10986.4 9977.4 10185.3 10552.8 10746.7 10847.3 6243.2 7209.9 7367.4 7407.6 7434.4 8216.5 10098.6 10405.5 10772.4 10964.1 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | [#3] mootools.html Cycles:180 Average:4331.46 Median:4521.75 stddev:2326.91 (51.5%) stddev-sans-first:2322.12 07:57:20 INFO - PROCESS | 29718 | Values: 1277.5 1316.1 1327.2 1568.5 1573.4 6200.9 6528.7 6530.4 6537.3 6539.9 5932.6 6124.8 6245.9 6396.4 6459.5 1957.9 1961.3 1978.2 1987.6 1988.1 1946.5 1965.0 1976.3 1992.3 1998.2 1665.1 1716.3 1916.5 1959.6 1980.8 1925.5 1941.5 1944.4 1945.9 1946.1 1949.8 1952.6 1960.0 1969.0 1983.6 6542.1 6596.1 6610.3 6618.4 6683.7 3864.6 3976.7 3978.9 3980.0 3980.2 2598.2 2723.6 2757.9 2769.6 2777.7 854.0 866.4 885.3 901.9 914.8 8732.9 8757.3 8763.2 8764.3 8782.2 3603.8 3648.4 3720.4 3721.3 3733.2 7658.4 7659.8 7662.5 7663.7 7666.8 4042.2 4048.0 4054.4 4055.0 4055.8 3165.8 3277.0 3561.1 3668.0 3734.9 3070.6 3104.8 3244.6 3248.0 3250.3 1036.9 1043.9 1046.9 1051.6 1085.1 707.4 712.2 721.0 725.6 751.6 4375.4 4411.7 4428.6 4440.7 4512.8 354.8 371.5 372.7 379.1 383.7 3125.6 3137.4 3139.2 3162.2 3166.9 7325.1 7748.3 7849.0 7871.4 7871.8 7798.7 7818.9 7822.7 7824.8 7830.8 6016.6 6175.7 6177.7 6270.6 6386.6 4500.3 4530.7 4569.0 4595.3 4704.2 7120.3 7147.2 7167.0 7167.1 7199.9 7062.9 7200.7 7204.3 7206.1 7218.6 5218.8 5635.8 5802.6 5815.0 5817.1 5755.4 5978.3 6212.0 6213.3 6336.2 5626.4 5739.3 5773.5 5804.4 5917.9 5723.9 5779.4 5831.4 5832.0 5879.4 5456.5 5500.1 5527.0 5537.5 5601.4 3878.3 3917.3 3959.4 3968.7 4028.3 3845.1 3892.7 3898.7 3929.7 3937.4 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | [#4] prototype.html Cycles:180 Average:4150.88 Median:4722.06 stddev:1217.84 (25.8%) stddev-sans-first:1185.92 07:57:20 INFO - PROCESS | 29718 | Values: 270.2 271.1 277.9 279.2 279.2 4685.3 4816.5 4853.1 4886.2 4908.6 4605.2 4696.4 4724.2 4741.8 4744.8 3547.8 3654.5 3689.4 3697.7 3724.9 3620.8 3705.7 3756.4 3760.9 3769.7 3696.9 3711.9 3727.1 3728.0 3730.0 3709.2 3717.7 3725.4 3731.3 3784.1 3136.5 3289.6 3317.4 3323.0 3327.7 4690.5 4698.5 4698.6 4708.4 4719.9 4268.6 4279.0 4282.9 4289.9 4297.2 4878.5 5019.3 5031.7 5044.2 5056.0 3570.9 3580.3 3598.2 3600.6 3614.7 5201.9 5212.5 5217.9 5227.3 5238.0 3599.2 3612.0 3612.8 3638.7 3663.9 3554.5 3649.5 3673.3 3682.7 3704.3 4191.4 4191.9 4195.6 4200.4 4216.9 4703.5 4792.1 4853.0 5017.9 5036.0 1234.0 1242.6 1244.7 1248.7 1249.4 837.8 854.4 863.3 865.9 868.6 4318.4 4321.4 4325.2 4330.9 4333.3 4979.5 5025.3 5027.1 5028.9 5038.4 4254.4 4332.9 4333.5 4339.9 4344.2 2501.8 2658.5 2681.2 2683.4 2711.2 4741.0 4757.4 4757.8 4765.4 4771.6 5064.2 5131.3 5136.7 5145.6 5158.3 4592.8 4906.8 4908.7 4921.3 4946.5 5210.0 5228.6 5232.4 5233.7 5251.5 4977.7 5123.6 5136.3 5154.6 5175.1 4951.8 4962.6 4969.1 4977.8 4979.2 3583.0 3595.7 3605.4 3617.4 3622.6 4992.7 5243.2 5252.8 5256.4 5261.3 4709.8 5035.3 5058.2 5064.6 5071.6 5031.2 5047.7 5062.4 5067.0 5068.9 4822.6 4944.2 4950.9 4967.5 4972.6 5086.3 5110.7 5115.9 5117.5 5117.6 4969.9 4970.6 4979.4 4988.8 5010.2 07:57:20 INFO - PROCESS | 29718 | 07:57:20 INFO - PROCESS | 29718 | [#5] yui.html Cycles:180 Average:15059.65 Median:26540.45 stddev:19898.57 (75.0%) stddev-sans-first:19924.71 07:57:20 INFO - PROCESS | 29718 | Values: 584.5 596.4 645.6 653.5 661.0 12603.4 13147.9 13745.0 13873.4 13946.3 11071.6 12991.7 13141.3 13194.1 13216.9 703.9 730.3 740.7 740.8 742.3 738.7 739.4 740.2 740.4 740.6 778.1 779.1 781.3 784.1 784.4 777.3 777.4 777.9 778.5 778.7 569.5 575.1 575.2 575.2 576.1 10967.5 11138.7 11140.1 11171.1 11179.2 10544.9 10753.8 10971.8 11340.2 11688.6 10269.5 10306.1 11229.9 11249.7 11253.9 3209.7 3214.9 3230.8 3289.3 3350.6 38999.6 52561.5 61980.0 66455.3 67056.0 9993.5 10191.1 10447.3 10450.7 10500.5 18405.0 18426.3 18437.0 18595.4 18611.0 4970.6 5049.5 6158.5 6205.4 6462.7 3483.5 3582.9 3590.6 3610.3 3616.1 2610.9 2716.9 2736.8 2739.5 2748.6 459.7 466.0 467.4 476.0 476.0 479.8 519.4 538.4 556.9 571.3 8015.1 8057.6 8370.4 8422.9 8575.3 552.9 570.0 572.9 586.5 590.0 3992.7 4016.9 4067.9 4106.1 4115.2 70231.3 72137.0 72171.6 74476.6 74523.0 61362.4 62742.0 62782.0 63973.4 64891.0 43881.1 55784.7 57133.7 59178.4 60248.0 7836.2 8025.9 8108.6 8167.0 8311.6 38602.8 39257.0 39716.6 40472.6 40673.6 51688.7 53850.0 54078.0 54493.2 54815.2 9093.9 9188.3 9231.9 9344.8 9350.6 10951.7 11139.3 11302.7 11365.2 11718.5 10584.4 10696.8 10720.4 10905.3 11375.9 10423.4 10654.6 10895.3 10928.0 11108.8 10097.8 10225.3 10420.9 10511.8 11000.3 8844.6 9067.1 9119.8 9257.7 9366.7 8232.5 8655.7 8804.0 8909.2 9017.1 07:57:20 INFO - PROCESS | 29718 | -------- Summary: end -------- 07:57:20 INFO - PROCESS | 29718 | 07:57:21 INFO - TEST-INFO | 29718: exit 0 07:57:21 INFO - TEST-OK | dromaeo_css | took 1122989ms 07:57:21 INFO - TEST-START | kraken 07:57:21 INFO - operating with platform_type : linux_ 07:57:21 INFO - Initialising browser for kraken test... 07:57:21 INFO - TEST-INFO | started process 30020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsyChrL/profile http://localhost:50261/getInfo.html) 07:57:25 INFO - PROCESS | 30020 | __metrics Screen width/height:1600/1200 07:57:25 INFO - PROCESS | 30020 | colorDepth:24 07:57:25 INFO - PROCESS | 30020 | Browser inner width/height: 1024/697 07:57:25 INFO - PROCESS | 30020 | __metrics 07:57:26 INFO - PROCESS | 30020 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:26 INFO - PROCESS | 30020 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:26 INFO - PROCESS | 30020 | console.error: PushService: 07:57:26 INFO - PROCESS | 30020 | stateChangeProcessEnqueue: Error transitioning state 07:57:26 INFO - PROCESS | 30020 | UnknownError 07:57:27 INFO - TEST-INFO | 30020: exit 0 07:57:27 INFO - Browser initialized. 07:57:27 INFO - Running cycle 1/1 for kraken test... 07:57:27 INFO - TEST-INFO | started process 30101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsyChrL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:39 INFO - PROCESS | 30101 | RSS: Main: 174481408 07:57:39 INFO - PROCESS | 30101 | 07:57:42 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50261/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:43 INFO - PROCESS | 30101 | RSS: Main: 234844160 07:57:43 INFO - PROCESS | 30101 | 07:57:46 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50261/tests/kraken/driver.html?testName=audio-dft) 07:57:46 INFO - PROCESS | 30101 | RSS: Main: 218128384 07:57:46 INFO - PROCESS | 30101 | 07:57:50 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50261/tests/kraken/driver.html?testName=audio-fft) 07:57:50 INFO - PROCESS | 30101 | RSS: Main: 300752896 07:57:50 INFO - PROCESS | 30101 | 07:57:52 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50261/tests/kraken/driver.html?testName=audio-oscillator) 07:57:53 INFO - PROCESS | 30101 | RSS: Main: 210190336 07:57:53 INFO - PROCESS | 30101 | 07:57:55 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:56 INFO - PROCESS | 30101 | RSS: Main: 214052864 07:57:56 INFO - PROCESS | 30101 | 07:57:59 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50261/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:00 INFO - PROCESS | 30101 | RSS: Main: 253251584 07:58:00 INFO - PROCESS | 30101 | 07:58:03 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50261/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:04 INFO - PROCESS | 30101 | RSS: Main: 253313024 07:58:04 INFO - PROCESS | 30101 | 07:58:06 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50261/tests/kraken/driver.html?testName=json-parse-financial) 07:58:07 INFO - PROCESS | 30101 | RSS: Main: 252026880 07:58:07 INFO - PROCESS | 30101 | 07:58:09 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:09 INFO - PROCESS | 30101 | RSS: Main: 214466560 07:58:09 INFO - PROCESS | 30101 | 07:58:11 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:12 INFO - PROCESS | 30101 | RSS: Main: 222158848 07:58:12 INFO - PROCESS | 30101 | 07:58:14 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:15 INFO - PROCESS | 30101 | RSS: Main: 230051840 07:58:15 INFO - PROCESS | 30101 | 07:58:18 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:18 INFO - PROCESS | 30101 | RSS: Main: 239030272 07:58:18 INFO - PROCESS | 30101 | 07:58:21 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:22 INFO - PROCESS | 30101 | RSS: Main: 235810816 07:58:22 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | Cycle 1(1): loaded http://localhost:50261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50261/tests/kraken/driver.html?testName=ai-astar) 07:58:24 INFO - PROCESS | 30101 | RSS: Main: 286654464 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | __start_tp_report 07:58:24 INFO - PROCESS | 30101 | _x_x_mozilla_page_load 07:58:24 INFO - PROCESS | 30101 | _x_x_mozilla_page_load_details 07:58:24 INFO - PROCESS | 30101 | |i|pagename|runs| 07:58:24 INFO - PROCESS | 30101 | |0;ai-astar;107;115;116;116;118;116;117;115;115;116 07:58:24 INFO - PROCESS | 30101 | |1;audio-beat-detection;155;133;130;178;132;132;134;128;154;127 07:58:24 INFO - PROCESS | 30101 | |2;audio-dft;161;161;161;162;162;162;163;162;159;160 07:58:24 INFO - PROCESS | 30101 | |3;audio-fft;76;76;76;119;77;76;75;77;97;78 07:58:24 INFO - PROCESS | 30101 | |4;audio-oscillator;84;84;111;85;86;85;107;83;84;101 07:58:24 INFO - PROCESS | 30101 | |5;imaging-gaussian-blur;117;117;117;117;116;116;118;117;117;117 07:58:24 INFO - PROCESS | 30101 | |6;imaging-darkroom;147;147;149;147;146;147;148;148;147;146 07:58:24 INFO - PROCESS | 30101 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:58:24 INFO - PROCESS | 30101 | |8;json-parse-financial;65;63;64;63;64;65;68;65;65;65 07:58:24 INFO - PROCESS | 30101 | |9;json-stringify-tinderbox;65;67;65;65;65;65;67;66;65;66 07:58:24 INFO - PROCESS | 30101 | |10;stanford-crypto-aes;87;86;86;85;87;86;93;85;85;93 07:58:24 INFO - PROCESS | 30101 | |11;stanford-crypto-ccm;151;157;149;151;147;145;144;153;185;153 07:58:24 INFO - PROCESS | 30101 | |12;stanford-crypto-pbkdf2;183;179;179;181;179;183;182;183;182;180 07:58:24 INFO - PROCESS | 30101 | |13;stanford-crypto-sha256-iterative;73;72;71;75;73;75;72;74;70;69 07:58:24 INFO - PROCESS | 30101 | __end_tp_report 07:58:24 INFO - PROCESS | 30101 | __start_cc_report 07:58:24 INFO - PROCESS | 30101 | _x_x_mozilla_cycle_collect,1984 07:58:24 INFO - PROCESS | 30101 | __end_cc_report 07:58:24 INFO - PROCESS | 30101 | __startTimestamp1480262304651__endTimestamp 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | ------- Summary: start ------- 07:58:24 INFO - PROCESS | 30101 | Number of tests: 14 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:3.00 (2.6%) stddev-sans-first:1.00 07:58:24 INFO - PROCESS | 30101 | Values: 107.0 115.0 116.0 116.0 118.0 116.0 117.0 115.0 115.0 116.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:133.50 stddev:16.63 (12.5%) stddev-sans-first:16.77 07:58:24 INFO - PROCESS | 30101 | Values: 155.0 133.0 130.0 178.0 132.0 132.0 134.0 128.0 154.0 127.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 07:58:24 INFO - PROCESS | 30101 | Values: 161.0 161.0 161.0 162.0 162.0 162.0 163.0 162.0 159.0 160.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:14.33 (18.7%) stddev-sans-first:14.99 07:58:24 INFO - PROCESS | 30101 | Values: 76.0 76.0 76.0 119.0 77.0 76.0 75.0 77.0 97.0 78.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:84.00 stddev:10.87 (12.9%) stddev-sans-first:11.23 07:58:24 INFO - PROCESS | 30101 | Values: 84.0 84.0 111.0 85.0 86.0 85.0 107.0 83.0 84.0 101.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:58:24 INFO - PROCESS | 30101 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 117.0 117.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:58:24 INFO - PROCESS | 30101 | Values: 147.0 147.0 149.0 147.0 146.0 147.0 148.0 148.0 147.0 146.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:58:24 INFO - PROCESS | 30101 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 07:58:24 INFO - PROCESS | 30101 | Values: 65.0 63.0 64.0 63.0 64.0 65.0 68.0 65.0 65.0 65.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 07:58:24 INFO - PROCESS | 30101 | Values: 65.0 67.0 65.0 65.0 65.0 65.0 67.0 66.0 65.0 66.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.50 stddev:3.09 (3.6%) stddev-sans-first:3.28 07:58:24 INFO - PROCESS | 30101 | Values: 87.0 86.0 86.0 85.0 87.0 86.0 93.0 85.0 85.0 93.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:152.00 stddev:11.75 (7.7%) stddev-sans-first:12.43 07:58:24 INFO - PROCESS | 30101 | Values: 151.0 157.0 149.0 151.0 147.0 145.0 144.0 153.0 185.0 153.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:182.00 stddev:1.73 (0.9%) stddev-sans-first:1.69 07:58:24 INFO - PROCESS | 30101 | Values: 183.0 179.0 179.0 181.0 179.0 183.0 182.0 183.0 182.0 180.0 07:58:24 INFO - PROCESS | 30101 | 07:58:24 INFO - PROCESS | 30101 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:2.01 (2.8%) stddev-sans-first:2.12 07:58:24 INFO - PROCESS | 30101 | Values: 73.0 72.0 71.0 75.0 73.0 75.0 72.0 74.0 70.0 69.0 07:58:24 INFO - PROCESS | 30101 | -------- Summary: end -------- 07:58:24 INFO - PROCESS | 30101 | 07:58:25 INFO - TEST-INFO | 30101: exit 0 07:58:26 INFO - TEST-OK | kraken | took 64837ms 07:58:26 INFO - SUITE-END | took 1187s 07:58:26 INFO - Completed test suite (00:19:48) 07:58:26 INFO - javascript benchmark 07:58:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.1313010141603, 2619.777318927891, 2640.0495821504255, 2655.641488399067, 2660.7073221945584, 4539.228331183698, 4591.517890621479, 4641.0, 4667.929981050287, 4686.367340409044, 4620.676552641316, 4626.583607475327, 4644.3730096436975, 4705.741184234866, 4776.068666610013, 4238.321868501025, 4260.978695106535, 4302.612764851163, 4336.588024137702, 4401.119776044788, 4201.369794530814, 4265.402843601898, 4288.506821715496, 4317.481902171744, 4360.825566977317, 4187.685923555746, 4219.810108545123, 4277.165952639237, 4324.870253892357, 4363.258246098155, 4266.4240327556, 4278.957210427887, 4292.0, 4294.957050429487, 4300.677449191323, 4270.081932384553, 4270.359446083081, 4272.893177670552, 4274.743515389056, 4277.850275240352, 4584.26651735724, 4594.632429405639, 4605.424321959722, 4606.56237657422, 4614.3770590970125, 4891.828785992473, 4915.655904086715, 4934.25986102084, 4944.35723355965, 4944.406671199479, 4911.631627627942, 4943.876403089916, 4968.726720030433, 4985.651004429691, 5043.924341134886, 4649.930251046237, 4668.299755036704, 4685.929711054337, 4687.55468230521, 4708.4820669726305, 5048.545630893237, 5084.110280700863, 5087.26234695967, 5089.134847076006, 5142.897142057138, 4748.4539277982785, 4766.165920963817, 4895.216765317532, 4899.191633380524, 4943.8516844494725, 4896.902061958741, 4917.237828136645, 4933.358663373739, 4940.629452790983, 5034.320366750515, 4923.75381230937, 4925.1381008324115, 4928.48250933654, 4933.87665308363, 5001.199808030698, 4935.111679897581, 4940.1601727706375, 4941.827036053721, 4942.827001054946, 4981.875453113628, 4200.327947528381, 4228.217779710763, 4229.936550951738, 4242.660587153082, 4259.403683484315, 3717.1450566369886, 3717.386631205821, 3743.2513497300647, 3748.6251374862295, 3758.1919887224376, 4296.505901821268, 4304.053108316165, 4308.91382172361, 4350.58669426404, 4351.82592696295, 4831.323614693945, 4867.780949857265, 4880.292357608127, 4970.850874473699, 4978.65149439543, 4250.914981700349, 4276.593723596254, 4290.37789520524, 4307.698461107692, 4346.608805207483, 4523.163214805271, 4528.162289976299, 4529.184746745617, 4535.25168347219, 4574.885627859264, 4563.429571303587, 4698.060387922361, 4700.059988002345, 4706.176419126571, 4751.976240118846, 4852.902941941071, 4883.633727470525, 4924.950750492592, 4943.184374578154, 4961.50384961501, 4706.317583950239, 4710.670253082389, 4716.434027916534, 4748.0, 4770.546798054179, 4902.63230257725, 4905.828296009622, 4906.018796240694, 4908.190148625579, 4947.1342515059005, 4692.859214223578, 4776.379070720784, 4781.067691800205, 4821.614270858393, 4982.4768399317545, 4710.7880145392855, 4712.646551508582, 4714.905701885875, 4723.220668589644, 4724.71651700899, 4819.59033482158, 4826.61387089025, 4890.755462226945, 4913.828016019565, 4964.851054468371, 4794.664373493822, 4796.040791841715, 4807.423109226916, 4808.927866082082, 4843.104025755247, 4702.318163866152, 4934.9753251233515, 4939.357883475125, 4946.0355230729665, 4984.028114517634, 4690.1792186366565, 4732.645051621211, 4753.263244197155, 4776.785044673067, 4826.758662066953], "value": 4561.533867992248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.9896594918578, 538.4427117932939, 549.2722143160311, 551.6552154903186, 557.6291765975626, 28390.43219135616, 31384.215394615145, 31403.0, 31422.214444638896, 31470.05589832306, 38755.22489550207, 39722.404163937565, 39943.20113597734, 43433.34849977245, 43460.78269608656, 7413.36986356159, 7531.397488200931, 7535.698572057111, 7540.17058123606, 7544.0569928758905, 7336.3397294243505, 7513.39892808574, 7594.658240379169, 7599.924000760005, 7605.0, 7310.451716121285, 9581.473018983954, 9802.901970980305, 9806.215502759762, 10157.796844063114, 9739.756506087333, 9801.362911410806, 9803.460809655466, 9816.214702823792, 9818.607255709763, 9487.810243795155, 9558.378705384128, 9560.091791279818, 9564.617415303379, 9565.569549370295, 35886.282274354366, 36198.8190059048, 36216.637833621855, 36224.63775362239, 36232.63767362345, 3027.258321711173, 3096.0, 3176.22182565273, 3427.091820667525, 3454.4300190468543, 27271.45457090867, 27893.58159627607, 28148.718512814816, 28181.29546761327, 28943.710562894314, 3288.0629020729216, 3306.9503957440656, 3312.801231926092, 3318.435865902802, 3478.913027174341, 238655.0, 239309.0, 239384.0, 239966.0, 240663.79668101724, 49787.75106124446, 50175.498245017814, 50210.74894625504, 50225.74887125614, 50384.0, 53902.0, 53958.7302063495, 53989.0, 54055.72972135114, 54064.0, 13203.801942970864, 13344.733105337838, 13399.196048237138, 13407.798883016763, 13408.530701425403, 10229.897701023043, 10298.073173414428, 10303.278770485995, 10303.639372621923, 10305.948470257601, 13525.39135738894, 13932.512362067278, 14653.560393188221, 15397.692046159014, 15404.92297538505, 5992.67040312787, 6366.649834259068, 6377.71300291488, 6387.776427825004, 6689.832754181087, 761.6534476813148, 866.5623859950684, 887.2192470625808, 944.7543638653999, 1000.9299349045497, 26053.348666283495, 26747.19758407251, 27148.1855544334, 27322.45355092927, 27355.726442735715, 896.6547879066607, 905.8324210021167, 925.2597921662777, 951.6050838901916, 952.9475878826593, 14147.64630884236, 14472.493462728755, 14509.492167774288, 14740.484083057256, 14778.556643300719, 354577.0, 357023.0, 357181.0, 358872.0, 359814.0, 41841.37237941433, 42279.57720422818, 46672.0, 48009.5199048012, 48138.0, 1047.1675018360422, 1109.9667009989876, 1117.7410284610723, 1136.0684238924168, 1145.2155273637584, 27438.451230974868, 28423.715762842934, 29318.41363172682, 29323.85338073296, 29628.0, 41438.0, 41881.0, 41950.32198712017, 42027.57972420237, 42048.36927446152, 316081.0, 531476.0, 540748.0, 541928.0, 542848.0, 23866.52266954686, 23869.0, 24076.51846963086, 24135.51728965446, 24176.274711758677, 40398.39402409025, 40425.0, 40707.796461017504, 41599.7920010398, 41870.16259674729, 34801.30397391987, 35188.296234075686, 35592.64407355997, 35700.46449303211, 35937.46093808647, 34679.65320346764, 34690.30619387649, 34881.825590871886, 35359.292814144086, 35378.292434151685, 33917.15207119842, 33987.4901876477, 34477.482837757954, 34799.30401392009, 35304.64695353014, 29914.0, 31931.36137277288, 32196.35607287888, 32266.193345166557, 32401.189970250933, 24396.146134885195, 24492.387690307885, 24748.87625561933, 25062.74937250604, 25220.495590088463], "value": 17284.845817134938, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7604125029979, 338.7103182486391, 365.7092611373958, 367.0, 377.8828563145425, 12534.874651253485, 13304.600861974144, 15538.92230538847, 16159.83840161598, 17482.21330040148, 16558.17209139544, 16571.751423728652, 16625.0, 16783.664326713457, 16852.578685532866, 3596.6762991330775, 4857.417109946802, 4906.89053747455, 5079.771410286546, 5082.2376643503585, 4908.165611845995, 5039.6976181429045, 5051.368578927634, 5052.040112378655, 5052.393712754456, 4988.950110498903, 5017.19724844025, 5019.54824065834, 5026.723530205837, 5029.321041659366, 4884.633652476061, 5145.691258524501, 5161.81933632321, 5222.399424066243, 5235.947640523584, 4890.0, 5064.493550644943, 5071.366079240095, 5071.670341427833, 5072.82245121419, 11194.888051119548, 11464.94267528657, 11468.19722619417, 11472.655820325404, 11481.885181148165, 1797.272104797559, 1866.831985121332, 2021.555257843272, 2181.0, 2300.1604414388626, 8299.29455996241, 8485.1090635483, 8724.302055835582, 8819.250363719091, 11698.2981021139, 1677.932882684691, 1711.9144042797811, 1726.343989284064, 1729.1008675488677, 1749.5276275405697, 66894.66552667254, 68566.65716671434, 68820.96768548476, 69887.30112698859, 70741.0, 9356.157945784777, 9515.524223788783, 9547.140757331874, 9740.805183896282, 9891.802163956681, 13343.866561334262, 13390.062695611214, 13412.664683382993, 13429.798553021712, 13438.462461501626, 6607.669616519155, 6760.749261386561, 7033.1560212773775, 7061.646917654097, 7139.464540159405, 6410.45511131559, 6422.614643121335, 6474.223093228843, 6564.6389448580785, 6620.205575330895, 3979.6617287530885, 4009.0578714002186, 4069.491313585802, 4207.431996680471, 4214.683898707609, 1529.2888806704937, 1599.9920000399923, 1624.3096683909291, 1659.9087050212354, 1702.4296860551854, 599.6222379900722, 764.7552783109352, 768.5580791045171, 802.5465611929242, 810.4934415990007, 16293.0, 16786.83213167877, 16847.0, 16853.325866965428, 17565.912170439067, 786.1745167574024, 788.9881651775228, 791.3313250303485, 802.0776107476332, 830.6926437218148, 8969.50667713282, 9359.953200233955, 9624.470654114091, 9654.613815447303, 9793.265505087147, 364172.0, 368505.0, 371545.0, 371811.0, 372159.0, 75709.62145189349, 76631.61684191543, 77433.0, 78186.21813781903, 78612.0, 849.9405041647149, 870.0951010948795, 874.7244617945327, 877.1886005444937, 879.7536689726759, 14712.926435367755, 14966.401343946556, 14983.77524337114, 15138.394464221748, 15709.0, 36256.456153157196, 36382.454263185544, 36454.8177259112, 36917.26165476622, 38197.80901095477, 48811.511884880696, 48890.75554622204, 48897.266541001205, 49267.50732492773, 49495.0, 6782.1861376635115, 6828.0, 6865.450763938773, 6941.861162776817, 7122.323379278961, 10226.744331391776, 11518.25131366492, 11569.0, 11575.826362604399, 11744.414504042186, 7928.85031670393, 9904.702858914245, 10426.218033647658, 10476.895231047896, 10676.199285053497, 10068.295219334575, 10380.948095259475, 10434.0, 10686.25196236287, 10986.395748233925, 9977.351472154287, 10185.287029907835, 10552.788944221225, 10746.731331716457, 10847.349159050482, 6243.219597550306, 7209.855802884018, 7367.447441441806, 7407.629618518945, 7434.405247580289, 8216.46592971455, 10098.646547370807, 10405.531751071068, 10772.353658780497, 10964.122870170526], "value": 7756.816934052057, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.5464710027936, 1316.0853207021119, 1327.2302064802416, 1568.5451219146448, 1573.3863793120686, 6200.937990620098, 6528.738850445977, 6530.412262896339, 6537.313582073879, 6539.901901471481, 5932.584719069667, 6124.816255512342, 6245.875082498347, 6396.424321811036, 6459.51553633477, 1957.921683132673, 1961.342950111707, 1978.2087165133917, 1987.602479504105, 1988.145097608028, 1946.523101840044, 1965.0174912543728, 1976.3082920977615, 1992.292736078693, 1998.2007197121195, 1665.0842036879728, 1716.3048965169064, 1916.492129585661, 1959.6374670685898, 1980.8415326773895, 1925.5282455798279, 1941.5049162463622, 1944.3777991042873, 1945.863789534726, 1946.124244090151, 1949.7855235924037, 1952.5509132899372, 1959.980400195994, 1968.9606207875906, 1983.6429442700307, 6542.116814230113, 6596.109525214083, 6610.305917878602, 6618.437432818217, 6683.6658167091455, 3864.594217607139, 3976.701747368959, 3978.900527486807, 3979.960200397988, 3980.223856348013, 2598.167702638612, 2723.6459260296233, 2757.931051723723, 2769.62610047643, 2777.722227777226, 853.9530325832139, 866.3502373220085, 885.3050355470924, 901.8782464367292, 914.7575892388522, 8732.8690069649, 8757.25563327118, 8763.16749908764, 8764.342674299389, 8782.209601135928, 3603.765755225902, 3648.3615367310613, 3720.404735242348, 3721.292954338667, 3733.178700685845, 7658.425618078666, 7659.846803063908, 7662.46362754613, 7663.693452261959, 7666.8083297918, 4042.2319759245647, 4048.0, 4054.39184122384, 4055.0, 4055.8377664893665, 3165.841707914595, 3276.983615081957, 3561.0919215599856, 3667.9816600916824, 3734.8506059757306, 3070.5854709614364, 3104.7826652134586, 3244.626867910173, 3247.9675203247666, 3250.3011852451364, 1036.8859425463193, 1043.9425831579335, 1046.858674079005, 1051.6161601015574, 1085.0831047764627, 707.3845754193884, 712.1952194020827, 720.9855802883912, 725.6190499987443, 751.6429695894407, 4375.431193944831, 4411.713238639478, 4428.645708343325, 4440.711353761995, 4512.81948722054, 354.8030842882225, 371.48734746050815, 372.7465323579938, 379.0996383588976, 383.74097484198614, 3125.6249250090136, 3137.3568418474156, 3139.21519620095, 3162.22525481254, 3166.857491412892, 7325.12098548167, 7748.263914928073, 7849.01887264092, 7871.448998570159, 7871.763847084597, 7798.699383681827, 7818.92181078182, 7822.687092516349, 7824.84350313002, 7830.765077047698, 6016.578839481194, 6175.660338681416, 6177.722002509808, 6270.623762574261, 6386.648734319657, 4500.252233893274, 4530.682852200314, 4568.954310456853, 4595.333676616939, 4704.247320428715, 7120.252373500708, 7147.213806481387, 7166.964165179141, 7167.068281123421, 7199.856002879808, 7062.858742825012, 7200.747973820891, 7204.279572042754, 7206.099237595301, 7218.602976836324, 5218.791248350175, 5635.830925072254, 5802.593818432838, 5815.011448053757, 5817.069268917122, 5755.424457554211, 5978.312494063239, 6211.9689401554515, 6213.285472170577, 6336.239651241881, 5626.43735626434, 5739.282589676291, 5773.451522105393, 5804.390538993345, 5917.881642367042, 5723.914141287801, 5779.422057794187, 5831.35855055935, 5831.970840145772, 5879.412058794086, 5456.48163424474, 5500.064988951808, 5527.0, 5537.501624853782, 5601.355844077821, 3878.340682083996, 3917.334053210904, 3959.4162335066203, 3968.722189446711, 4028.254772867029, 3845.0964023453907, 3892.746971446847, 3898.7270891037356, 3929.7052721045466, 3937.3897045957924], "value": 3498.1375549469085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.24870859011946, 271.116161314116, 277.8971780441236, 279.2070519723986, 279.2488206723911, 4685.25035994241, 4816.518348165182, 4853.126437241295, 4886.218205087187, 4908.582770464511, 4605.240135377659, 4696.389469368985, 4724.220503616908, 4741.786619602118, 4744.833930812422, 3547.8048707321086, 3654.470101835232, 3689.3912504436803, 3697.7411581189326, 3724.944125838115, 3620.7870363428283, 3705.74059815813, 3756.361418558838, 3760.9435858462143, 3769.6795772359383, 3696.9445458318146, 3711.925761484769, 3727.1054946812706, 3727.9813600931957, 3730.048837546422, 3709.2396058808013, 3717.6654101130894, 3725.4353171667694, 3731.309707704056, 3784.129650180474, 3136.466800643896, 3289.6381398046196, 3317.3862835375535, 3323.0, 3327.672327672328, 4690.484046754854, 4698.483166851644, 4698.590422873124, 4708.4349878014855, 4719.905601887977, 4268.55180206077, 4278.957210427887, 4282.8715138545585, 4289.892752681177, 4297.183535128347, 4878.487758785312, 5019.272205530214, 5031.723255220962, 5044.167712327461, 5056.002878862865, 3570.893173027926, 3580.3197392495345, 3598.208394153282, 3600.5859326177565, 3614.6625748473234, 5201.921971170435, 5212.478752124757, 5217.921731174036, 5227.307936412751, 5237.973810130963, 3599.2441587266444, 3612.0066981580276, 3612.837422316002, 3638.7270954678506, 3663.8717644882836, 3554.4845997330244, 3649.5073165122367, 3673.3204357194004, 3682.650148235913, 3704.2776658551325, 4191.392248124005, 4191.8532851350055, 4195.601417865298, 4200.411942328015, 4216.915661686749, 4703.506131856106, 4792.0895029944195, 4852.951470485321, 5017.93905717512, 5035.96762663653, 1234.0066246671336, 1242.6147894152841, 1244.7012716947868, 1248.7440074784647, 1249.3508568689424, 837.8001428731145, 854.4232642965973, 863.3093525179831, 865.8700395983302, 868.6395146014333, 4318.438602981592, 4321.395004699281, 4325.199838029975, 4330.891727706769, 4333.306670932636, 4979.456368525769, 5025.291400923704, 5027.095122877917, 5028.949710502921, 5038.395392552917, 4254.446921900133, 4332.913341733148, 4333.458317710286, 4339.913201735948, 4344.218040752632, 2501.7873480753974, 2658.5214661360756, 2681.2492502099444, 2683.409649877024, 2711.227300219428, 4741.0, 4757.381540399726, 4757.8096876125255, 4765.404324459442, 4771.570558649669, 5064.227520367842, 5131.281620573122, 5136.717480538531, 5145.614078944094, 5158.329417175743, 4592.839250626212, 4906.797834530563, 4908.748269191334, 4921.26181072842, 4946.491320147389, 5210.0, 5228.607854410859, 5232.398274198364, 5233.712145832016, 5251.52736253739, 4977.676451030671, 5123.6157288202785, 5136.30659860914, 5154.639175257696, 5175.14610089331, 4951.801927922843, 4962.578180854668, 4969.055879382906, 4977.751112444291, 4979.228219625964, 3583.0, 3595.676389124991, 3605.3690604144695, 3617.439296908983, 3622.565292164957, 4992.72540010303, 5243.187305967581, 5252.791857872634, 5256.421793602777, 5261.342332208474, 4709.788059537261, 5035.345405097314, 5058.241263810458, 5064.645474816874, 5071.568916642127, 5031.245313203049, 5047.7476126192805, 5062.417821950376, 5067.0, 5068.873278168076, 4822.638302127425, 4944.233643785219, 4950.851474455772, 4967.453580106113, 4972.552470277692, 5086.287919691172, 5110.693358398508, 5115.872103197301, 5117.462666419972, 5117.616178786531, 4969.850904472872, 4970.62720295972, 4979.4024717032735, 4988.825391111293, 5010.173321402073], "value": 3757.2739238349372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5473997117164, 596.3887015808798, 645.5513418174371, 653.483747839207, 660.9985871404823, 12603.432845521951, 13147.868521314784, 13745.0, 13873.445062197525, 13946.302684865754, 11071.612493562727, 12991.675208119801, 13141.342932853368, 13194.07641465098, 13216.867831321684, 703.8592281543686, 730.3135053050116, 740.6963145110506, 740.8333125046876, 742.3207764895142, 738.674983007475, 739.3530660671885, 740.1968863782802, 740.4150720930486, 740.6074780366388, 778.105179044101, 779.0884664942031, 781.3436713160944, 784.0630446616295, 784.396015068397, 777.261601478592, 777.4014009212931, 777.9299863012328, 778.4978688745728, 778.6846327237449, 569.5443645083958, 575.0913556580592, 575.1573944171809, 575.2119596153296, 576.1473019930485, 10967.50646220914, 11138.665840024812, 11140.108791296676, 11171.050460710849, 11179.161562882817, 10544.947275263652, 10753.784924301548, 10971.780564388668, 11340.206185567014, 11688.649340519798, 10269.537870795757, 10306.072453479148, 11229.887701123047, 11249.718757031058, 11253.887461125447, 3209.6629853865243, 3214.8553315100876, 3230.7576931729977, 3289.276359200972, 3350.5811773528308, 38999.610003899885, 52561.47438525604, 61979.99999999955, 66455.3354466454, 67056.0, 9993.450360230112, 10191.133753631024, 10447.320924140058, 10450.738731531772, 10500.474976251156, 18405.0, 18426.262949481872, 18436.98596577201, 18595.442136735648, 18611.0, 4970.577500912463, 5049.469805670426, 6158.538109641795, 6205.410486003822, 6462.676866156673, 3483.494893240466, 3582.946255806165, 3590.551181102362, 3610.332088563624, 3616.0959760059986, 2610.8825102870414, 2716.8641567921527, 2736.7947403944786, 2739.5068887600423, 2748.5877118432395, 459.7172738765702, 465.97903094360834, 467.4320700349092, 475.950025247351, 476.04077783266746, 479.7553247843625, 519.4182515582572, 538.3714264350372, 556.9498745112959, 571.2716286734446, 8015.078265999368, 8057.59712014397, 8370.372222083368, 8422.915770842214, 8575.313974881994, 552.9004779139793, 569.9772009119589, 572.9229049387126, 586.5454272938507, 589.9557533185028, 3992.7005474589523, 4016.9196616068098, 4067.898302542401, 4106.117184805281, 4115.1563929395, 70231.2976870235, 72137.0, 72171.63914180396, 74476.62761686157, 74523.0, 61362.38637613656, 62742.0, 62782.0, 63973.36026639674, 64891.0, 43881.12237755227, 55784.72107639436, 57133.71433142808, 59178.40821591729, 60248.0, 7836.216378362118, 8025.919740802751, 8108.566412640232, 8166.959165204136, 8311.584420779058, 38602.80698596489, 39257.0, 39716.60283397244, 40472.59527404806, 40673.593264068164, 51688.74155629198, 53850.0, 54078.0, 54493.18260226179, 54815.17777233265, 9093.863592046257, 9188.310876684141, 9231.861522077308, 9344.813103737752, 9350.625974960925, 10951.671449856518, 11139.33164010162, 11302.660920172408, 11365.204435689422, 11718.531258749554, 10584.417857017937, 10696.786064278514, 10720.410377429316, 10905.291156074829, 11375.919287667659, 10423.374597524173, 10654.62708805188, 10895.291806032583, 10928.0, 11108.777824443627, 10097.848532272168, 10225.284230103822, 10420.947895260475, 10511.842322365324, 11000.339979601249, 8844.646214151362, 9067.093290671144, 9119.772005699911, 9257.67598134062, 9366.718998430058, 8232.547209903274, 8655.653773848975, 8803.955980220058, 8909.1536304051, 9017.098290171192], "value": 6023.21868452861, "unit": "score"}], "name": "dromaeo_css", "value": 6037.296109017382, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 116.0, 118.0, 116.0, 117.0, 115.0, 115.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 130.0, 178.0, 132.0, 132.0, 134.0, 128.0, 154.0, 127.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 159.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 119.0, 77.0, 76.0, 75.0, 77.0, 97.0, 78.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 85.0, 86.0, 85.0, 107.0, 83.0, 84.0, 101.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 65.0, 68.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 85.0, 87.0, 86.0, 93.0, 85.0, 85.0, 93.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 157.0, 149.0, 151.0, 147.0, 145.0, 144.0, 153.0, 185.0, 153.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 179.0, 181.0, 179.0, 183.0, 182.0, 183.0, 182.0, 180.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 75.0, 73.0, 75.0, 72.0, 74.0, 70.0, 69.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1574.1, "alertThreshold": 2.0}]} 07:58:26 INFO - Return code: 0 07:58:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:26 INFO - # TBPL SUCCESS # 07:58:26 INFO - Running post-action listener: _resource_record_post_action 07:58:26 INFO - [mozharness: 2016-11-27 15:58:26.441726Z] Finished run-tests step (success) 07:58:26 INFO - Running post-run listener: _resource_record_post_run 07:58:26 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401915904; Read time: 4; Write time: 263628 07:58:26 INFO - TinderboxPrint: CPU usage
13.1% 07:58:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 07:58:26 INFO - TinderboxPrint: I/O write bytes / time
401,915,904 / 263,628 07:58:26 INFO - TinderboxPrint: CPU idle
8,350.5 (86.9%) 07:58:26 INFO - TinderboxPrint: CPU user
1,206.3 (12.6%) 07:58:26 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110309376; Read time: 0; Write time: 63640 07:58:26 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290476032; Read time: 0; Write time: 199968 07:58:27 INFO - Running post-run listener: _upload_blobber_files 07:58:27 INFO - Blob upload gear active. 07:58:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:27 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 07:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:27 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:28 INFO - (blobuploader) - INFO - Done attempting. 07:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:29 INFO - (blobuploader) - INFO - Done attempting. 07:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:32 INFO - (blobuploader) - INFO - Done attempting. 07:58:32 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:32 INFO - Return code: 0 07:58:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e66fa11bc4ec77bf077e732e6688f82f34b0a56b9f0d109711e2084b31eeeec86987bf0b242bea053fd87618876808762213f5a4e61694ccee211eb81609d91f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3aadefc360a929d898bc5950dea5c853d3170e042967abcf6e06705c75487f82995691a82eb86ae24458bbdff3d02e082fa4bbbba678984267e63a5d22f7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87421bc3db9278b4726ee6fc92386a75f236e9baa6067240276511bae142c275f993e78e09ed4a8732b6a8087dcc1f02e3b4a2fc89ccd725fc7cb5e3dd1aae76"} 07:58:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:32 INFO - Contents: 07:58:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e66fa11bc4ec77bf077e732e6688f82f34b0a56b9f0d109711e2084b31eeeec86987bf0b242bea053fd87618876808762213f5a4e61694ccee211eb81609d91f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3aadefc360a929d898bc5950dea5c853d3170e042967abcf6e06705c75487f82995691a82eb86ae24458bbdff3d02e082fa4bbbba678984267e63a5d22f7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87421bc3db9278b4726ee6fc92386a75f236e9baa6067240276511bae142c275f993e78e09ed4a8732b6a8087dcc1f02e3b4a2fc89ccd725fc7cb5e3dd1aae76"} 07:58:32 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:32 INFO - Copying logs to upload dir... 07:58:32 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.023181 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-27 07:58:31.434262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 07:58:31.442114) ========= 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=db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e66fa11bc4ec77bf077e732e6688f82f34b0a56b9f0d109711e2084b31eeeec86987bf0b242bea053fd87618876808762213f5a4e61694ccee211eb81609d91f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3aadefc360a929d898bc5950dea5c853d3170e042967abcf6e06705c75487f82995691a82eb86ae24458bbdff3d02e082fa4bbbba678984267e63a5d22f7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87421bc3db9278b4726ee6fc92386a75f236e9baa6067240276511bae142c275f993e78e09ed4a8732b6a8087dcc1f02e3b4a2fc89ccd725fc7cb5e3dd1aae76"} build_url:https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/BJon0003TYm2dO_5JJZ4qA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e66fa11bc4ec77bf077e732e6688f82f34b0a56b9f0d109711e2084b31eeeec86987bf0b242bea053fd87618876808762213f5a4e61694ccee211eb81609d91f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3aadefc360a929d898bc5950dea5c853d3170e042967abcf6e06705c75487f82995691a82eb86ae24458bbdff3d02e082fa4bbbba678984267e63a5d22f7a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87421bc3db9278b4726ee6fc92386a75f236e9baa6067240276511bae142c275f993e78e09ed4a8732b6a8087dcc1f02e3b4a2fc89ccd725fc7cb5e3dd1aae76"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 07:58:31.471982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 07:58:31.472349) ========= 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=db7e7c15f3ca076d53731445000001ba-1480258313.472502-327241332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 07:58:31.529760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 07:58:31.530126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 07:58:31.530460) ========= ========= Total master_lag: 0.31 =========