builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1475731805.5 results: success (0) buildid: 20161005205900 builduid: 645d49812ed2464a939c13f49fa5143f revision: 2273369348da5bb61af45c743ebe0faff1321d3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.502968) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.503457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.503759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.518456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.518783) ========= 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=62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 22:30:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 135K=0.09s 2016-10-05 22:30:05 (135 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.246269 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.778799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.779118) ========= 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=62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017951 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.828642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:05.829012) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2273369348da5bb61af45c743ebe0faff1321d3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2273369348da5bb61af45c743ebe0faff1321d3e --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=62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 22:30:06,090 truncating revision to first 12 chars 2016-10-05 22:30:06,091 Setting DEBUG logging. 2016-10-05 22:30:06,091 attempt 1/10 2016-10-05 22:30:06,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2273369348da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 22:30:06,546 unpacking tar archive at: autoland-2273369348da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:06.614456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:06.614801) ========= script_repo_revision: 2273369348da5bb61af45c743ebe0faff1321d3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:06.615213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:06.615487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 22:30:06.622978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-05 22:30:06.623262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:30:06 INFO - MultiFileLogger online at 20161005 22:30:06 in /builds/slave/test 22:30:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 22:30:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:30:06 INFO - {'append_to_log': False, 22:30:06 INFO - 'base_work_dir': '/builds/slave/test', 22:30:06 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:30:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:30:06 INFO - 'branch': 'Autoland-Non-PGO', 22:30:06 INFO - 'buildbot_json_path': 'buildprops.json', 22:30:06 INFO - 'config_files': ('talos/linux_config.py',), 22:30:06 INFO - 'default_actions': ('clobber', 22:30:06 INFO - 'read-buildbot-config', 22:30:06 INFO - 'download-and-extract', 22:30:06 INFO - 'populate-webroot', 22:30:06 INFO - 'create-virtualenv', 22:30:06 INFO - 'install', 22:30:06 INFO - 'run-tests'), 22:30:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:30:06 INFO - 'download_minidump_stackwalk': True, 22:30:06 INFO - 'download_symbols': 'ondemand', 22:30:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:30:06 INFO - 'tooltool.py': '/tools/tooltool.py', 22:30:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:30:06 INFO - '/tools/misc-python/virtualenv.py')}, 22:30:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:30:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:30:06 INFO - 'installer_path': 'installer.exe', 22:30:06 INFO - 'log_level': 'info', 22:30:06 INFO - 'log_name': 'talos', 22:30:06 INFO - 'log_to_console': True, 22:30:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:30:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:30:06 INFO - 'opt_config_files': (), 22:30:06 INFO - 'pip_index': False, 22:30:06 INFO - 'sps_profile': False, 22:30:06 INFO - 'sps_profile_interval': 0, 22:30:06 INFO - 'suite': 'dromaeojs', 22:30:06 INFO - 'system_bits': '32', 22:30:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:30:06 INFO - 'title': 'talos-linux64-ix-018', 22:30:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:30:06 INFO - 'use_talos_json': True, 22:30:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:30:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:30:06 INFO - 'work_dir': 'build'} 22:30:06 INFO - [mozharness: 2016-10-06 05:30:06.985291Z] Running clobber step. 22:30:06 INFO - Running pre-action listener: _resource_record_pre_action 22:30:06 INFO - Running main action method: clobber 22:30:06 INFO - rmtree: /builds/slave/test/build 22:30:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:30:07 INFO - Running post-action listener: _resource_record_post_action 22:30:07 INFO - [mozharness: 2016-10-06 05:30:07.434524Z] Finished clobber step (success) 22:30:07 INFO - [mozharness: 2016-10-06 05:30:07.434624Z] Running read-buildbot-config step. 22:30:07 INFO - Running pre-action listener: _resource_record_pre_action 22:30:07 INFO - Running main action method: read_buildbot_config 22:30:07 INFO - Using buildbot properties: 22:30:07 INFO - { 22:30:07 INFO - "project": "", 22:30:07 INFO - "product": "firefox", 22:30:07 INFO - "script_repo_revision": "production", 22:30:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 22:30:07 INFO - "repository": "", 22:30:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 22:30:07 INFO - "buildid": "20161005205900", 22:30:07 INFO - "pgo_build": "False", 22:30:07 INFO - "basedir": "/builds/slave/test", 22:30:07 INFO - "buildnumber": 795, 22:30:07 INFO - "slavename": "talos-linux64-ix-018", 22:30:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:30:07 INFO - "platform": "ubuntu64_hw", 22:30:07 INFO - "scheduler": "tests-autoland-linux64-talos", 22:30:07 INFO - "branch": "autoland", 22:30:07 INFO - "repo_path": "integration/autoland", 22:30:07 INFO - "revision": "2273369348da5bb61af45c743ebe0faff1321d3e", 22:30:07 INFO - "stage_platform": "linux64", 22:30:07 INFO - "builduid": "645d49812ed2464a939c13f49fa5143f", 22:30:07 INFO - "slavebuilddir": "test" 22:30:07 INFO - } 22:30:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:30:07 INFO - Running post-action listener: _resource_record_post_action 22:30:07 INFO - [mozharness: 2016-10-06 05:30:07.437029Z] Finished read-buildbot-config step (success) 22:30:07 INFO - [mozharness: 2016-10-06 05:30:07.437117Z] Running download-and-extract step. 22:30:07 INFO - Running pre-action listener: _resource_record_pre_action 22:30:07 INFO - Running main action method: download_and_extract 22:30:07 INFO - mkdir: /builds/slave/test/build/tests 22:30: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')]} 22:30:07 INFO - trying https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:30:07 INFO - Downloading https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:30:08 INFO - Downloaded 1361 bytes. 22:30:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:30:08 INFO - Using the following test package requirements: 22:30:08 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:30:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:30:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:30:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'jsshell-linux-x86_64.zip'], 22:30:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:30:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:30:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:30:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:30:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:30:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:30:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:30:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:30:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:30:08 INFO - Fetch https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:30:08 INFO - Http code: 200 22:30:08 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 22:30:08 INFO - x-amz-cf-id: zNWvTJeSk8rNn7A8XaoWycxyz_sAmFZCqMd9JSC-u46Ccd3rR1qXxA== 22:30:08 INFO - x-amz-version-id: oAFVtpHBwOI2Dfhpq9pAnla1gi0wsqTE 22:30:08 INFO - Expected file size: 20421546 22:30:08 INFO - Obtained file size: 20421546 22:30:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:30:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:30:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:30:12 INFO - Fetch https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:30:13 INFO - Http code: 200 22:30:13 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 22:30:13 INFO - x-amz-cf-id: bWGou-bAEESkACtQR3g-6sC0qxPlbin5xSxpjkF5watCd5LoBws-XQ== 22:30:13 INFO - x-amz-version-id: oAFVtpHBwOI2Dfhpq9pAnla1gi0wsqTE 22:30:13 INFO - Expected file size: 20421546 22:30:13 INFO - Obtained file size: 20421546 22:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:30:18 INFO - Http code: 200 22:30:18 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 22:30:18 INFO - x-amz-cf-id: hUODQBmIGMYb-nXHlG0OV2klGTj2coHmoqHVQOHsFp-n5Ne2T1IeAg== 22:30:18 INFO - x-amz-version-id: Zkz1bLnyNbEMLKZxSydpS8lVTiVK57OZ 22:30:18 INFO - Expected file size: 14409006 22:30:18 INFO - Obtained file size: 14409006 22:30:19 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')]} 22:30:19 INFO - trying https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:30:20 INFO - Downloaded 55808678 bytes. 22:30:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:30:20 INFO - mkdir: /builds/slave/test/properties 22:30:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:30:20 INFO - Writing to file /builds/slave/test/properties/build_url 22:30:20 INFO - Contents: 22:30:20 INFO - build_url:https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:30:21 INFO - Running post-action listener: _resource_record_post_action 22:30:21 INFO - Running post-action listener: set_extra_try_arguments 22:30:21 INFO - [mozharness: 2016-10-06 05:30:21.620059Z] Finished download-and-extract step (success) 22:30:21 INFO - [mozharness: 2016-10-06 05:30:21.620284Z] Running populate-webroot step. 22:30:21 INFO - Running pre-action listener: _resource_record_pre_action 22:30:21 INFO - Running main action method: populate_webroot 22:30:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:30:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:30:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:30:21 INFO - '--tppagecycles', 22:30:21 INFO - '7'], 22:30:21 INFO - 'tests': ['tsvgm']}}, 22:30:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:30:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:30:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:30:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:30:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:30:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:30:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['damp', 'tps']}, 22:30:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'tests': ['damp', 'tps']}, 22:30:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['dromaeo_dom']}, 22:30:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:30:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['basic_compositor_video']}, 22:30:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:30:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['a11yr', 22:30:21 INFO - 'ts_paint', 22:30:21 INFO - 'tpaint', 22:30:21 INFO - 'sessionrestore', 22:30:21 INFO - 'sessionrestore_no_auto_restore', 22:30:21 INFO - 'tabpaint']}, 22:30:21 INFO - 'other-e10s': {'tests': ['a11yr', 22:30:21 INFO - 'ts_paint', 22:30:21 INFO - 'tpaint', 22:30:21 INFO - 'sessionrestore', 22:30:21 INFO - 'sessionrestore_no_auto_restore', 22:30:21 INFO - 'tabpaint']}, 22:30:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:30:21 INFO - 'ts_paint', 22:30:21 INFO - 'tpaint', 22:30:21 INFO - 'sessionrestore', 22:30:21 INFO - 'sessionrestore_no_auto_restore', 22:30:21 INFO - 'tabpaint']}, 22:30:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:30:21 INFO - 'ts_paint', 22:30:21 INFO - 'tpaint', 22:30:21 INFO - 'sessionrestore', 22:30:21 INFO - 'sessionrestore_no_auto_restore', 22:30:21 INFO - 'tabpaint']}, 22:30:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['a11yr', 22:30:21 INFO - 'ts_paint', 22:30:21 INFO - 'tpaint', 22:30:21 INFO - 'sessionrestore', 22:30:21 INFO - 'sessionrestore_no_auto_restore', 22:30:21 INFO - 'tabpaint']}, 22:30:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['a11yr', 22:30:21 INFO - 'ts_paint', 22:30:21 INFO - 'tpaint', 22:30:21 INFO - 'sessionrestore', 22:30:21 INFO - 'sessionrestore_no_auto_restore', 22:30:21 INFO - 'tabpaint']}, 22:30:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['tsvgx', 22:30:21 INFO - 'tsvgr_opacity', 22:30:21 INFO - 'tart', 22:30:21 INFO - 'tscrollx', 22:30:21 INFO - 'cart']}, 22:30:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:30:21 INFO - 'tsvgr_opacity', 22:30:21 INFO - 'tart', 22:30:21 INFO - 'tscrollx', 22:30:21 INFO - 'cart']}, 22:30:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'talos_options': ['--disable-e10s'], 22:30:21 INFO - 'tests': ['tp5o']}, 22:30:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'tests': ['tp5o']}, 22:30:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'talos_options': ['--disable-e10s', 22:30:21 INFO - '--xperf_path', 22:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:30:21 INFO - 'tests': ['tp5n']}, 22:30:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:21 INFO - 'talos_options': ['--xperf_path', 22:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:30:21 INFO - 'tests': ['tp5n']}}, 22:30:21 INFO - 'talos.zip': {'path': '', 22:30:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:30:21 INFO - Running post-action listener: _resource_record_post_action 22:30:21 INFO - [mozharness: 2016-10-06 05:30:21.641817Z] Finished populate-webroot step (success) 22:30:21 INFO - [mozharness: 2016-10-06 05:30:21.641906Z] Running create-virtualenv step. 22:30:21 INFO - Running pre-action listener: _resource_record_pre_action 22:30:21 INFO - Running main action method: create_virtualenv 22:30:21 INFO - Creating virtualenv /builds/slave/test/build/venv 22:30:21 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 22:30:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:30:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:30:21 INFO - Using real prefix '/usr' 22:30:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:30:22 INFO - Installing distribute.............................................................................................................................................................................................done. 22:30:24 INFO - Installing pip.................done. 22:30:24 INFO - Return code: 0 22:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:30:24 INFO - Reading from file tmpfile_stdout 22:30:24 INFO - Output received: 22:30:24 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) 22:30:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:30:24 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')]} 22:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:24 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')]} 22:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:24 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:24 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 22:30:24 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 22:30:24 INFO - Using env: {'DISPLAY': ':0', 22:30:24 INFO - 'HOME': '/home/cltbld', 22:30:24 INFO - 'LANG': 'en_US.UTF-8', 22:30:24 INFO - 'LANGUAGE': 'en_US:en', 22:30:24 INFO - 'LOGNAME': 'cltbld', 22:30:24 INFO - 'MAIL': '/var/mail/cltbld', 22:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:24 INFO - 'MOZ_NO_REMOTE': '1', 22:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:24 INFO - 'NO_EM_RESTART': '1', 22:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:24 INFO - 'PWD': '/builds/slave/test', 22:30:24 INFO - 'SHELL': '/bin/bash', 22:30:24 INFO - 'SHLVL': '1', 22:30:24 INFO - 'TERM': 'linux', 22:30:24 INFO - 'TMOUT': '86400', 22:30:24 INFO - 'USER': 'cltbld', 22:30:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:24 INFO - '_': '/tools/buildbot/bin/python'} 22:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:24 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 22:30:24 INFO - Cleaning up... 22:30:24 INFO - Return code: 0 22:30:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:30:24 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')]} 22:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:24 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')]} 22:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:24 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:24 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 22:30:24 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 22:30:24 INFO - Using env: {'DISPLAY': ':0', 22:30:24 INFO - 'HOME': '/home/cltbld', 22:30:24 INFO - 'LANG': 'en_US.UTF-8', 22:30:24 INFO - 'LANGUAGE': 'en_US:en', 22:30:24 INFO - 'LOGNAME': 'cltbld', 22:30:24 INFO - 'MAIL': '/var/mail/cltbld', 22:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:24 INFO - 'MOZ_NO_REMOTE': '1', 22:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:24 INFO - 'NO_EM_RESTART': '1', 22:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:24 INFO - 'PWD': '/builds/slave/test', 22:30:24 INFO - 'SHELL': '/bin/bash', 22:30:24 INFO - 'SHLVL': '1', 22:30:24 INFO - 'TERM': 'linux', 22:30:24 INFO - 'TMOUT': '86400', 22:30:24 INFO - 'USER': 'cltbld', 22:30:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:24 INFO - '_': '/tools/buildbot/bin/python'} 22:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:24 INFO - Downloading/unpacking psutil>=3.1.1 22:30:24 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 22:30:24 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 22:30:24 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 22:30:24 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 22:30:24 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 22:30:24 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 22:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:30:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:26 INFO - Installing collected packages: psutil 22:30:26 INFO - Running setup.py install for psutil 22:30:26 INFO - building 'psutil._psutil_linux' extension 22:30:26 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 22:30:27 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 22:30:27 INFO - building 'psutil._psutil_posix' extension 22:30:27 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 22:30:27 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 22:30:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:27 INFO - Successfully installed psutil 22:30:27 INFO - Cleaning up... 22:30:27 INFO - Return code: 0 22:30:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:30:27 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')]} 22:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:27 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')]} 22:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:27 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:27 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 22:30:27 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 22:30:27 INFO - Using env: {'DISPLAY': ':0', 22:30:27 INFO - 'HOME': '/home/cltbld', 22:30:27 INFO - 'LANG': 'en_US.UTF-8', 22:30:27 INFO - 'LANGUAGE': 'en_US:en', 22:30:27 INFO - 'LOGNAME': 'cltbld', 22:30:27 INFO - 'MAIL': '/var/mail/cltbld', 22:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:27 INFO - 'MOZ_NO_REMOTE': '1', 22:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:27 INFO - 'NO_EM_RESTART': '1', 22:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:27 INFO - 'PWD': '/builds/slave/test', 22:30:27 INFO - 'SHELL': '/bin/bash', 22:30:27 INFO - 'SHLVL': '1', 22:30:27 INFO - 'TERM': 'linux', 22:30:27 INFO - 'TMOUT': '86400', 22:30:27 INFO - 'USER': 'cltbld', 22:30:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:27 INFO - '_': '/tools/buildbot/bin/python'} 22:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:30:27 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 22:30:27 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 22:30:27 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 22:30:27 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 22:30:27 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 22:30:27 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 22:30:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:30:29 INFO - Installing collected packages: mozsystemmonitor 22:30:29 INFO - Running setup.py install for mozsystemmonitor 22:30:29 INFO - Successfully installed mozsystemmonitor 22:30:29 INFO - Cleaning up... 22:30:29 INFO - Return code: 0 22:30:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:29 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:29 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 22:30:29 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 22:30:29 INFO - Using env: {'DISPLAY': ':0', 22:30:29 INFO - 'HOME': '/home/cltbld', 22:30:29 INFO - 'LANG': 'en_US.UTF-8', 22:30:29 INFO - 'LANGUAGE': 'en_US:en', 22:30:29 INFO - 'LOGNAME': 'cltbld', 22:30:29 INFO - 'MAIL': '/var/mail/cltbld', 22:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:29 INFO - 'MOZ_NO_REMOTE': '1', 22:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:29 INFO - 'NO_EM_RESTART': '1', 22:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:29 INFO - 'PWD': '/builds/slave/test', 22:30:29 INFO - 'SHELL': '/bin/bash', 22:30:29 INFO - 'SHLVL': '1', 22:30:29 INFO - 'TERM': 'linux', 22:30:29 INFO - 'TMOUT': '86400', 22:30:29 INFO - 'USER': 'cltbld', 22:30:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:29 INFO - '_': '/tools/buildbot/bin/python'} 22:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:29 INFO - Downloading/unpacking jsonschema==2.5.1 22:30:29 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 22:30:29 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 22:30:29 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 22:30:29 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 22:30:29 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 22:30:29 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 22:30:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:30:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:30:31 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 22:30:31 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 22:30:31 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 22:30:31 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 22:30:31 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 22:30:31 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 22:30:32 INFO - Downloading functools32-3.2.3-2.tar.gz 22:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:30:32 INFO - warning: no files found matching '*.txt' 22:30:32 INFO - no previously-included directories found matching 'build' 22:30:32 INFO - no previously-included directories found matching 'dist' 22:30:32 INFO - no previously-included directories found matching '.git*' 22:30:32 INFO - Installing collected packages: jsonschema, functools32 22:30:32 INFO - Running setup.py install for functools32 22:30:32 INFO - warning: no files found matching '*.txt' 22:30:32 INFO - no previously-included directories found matching 'build' 22:30:32 INFO - no previously-included directories found matching 'dist' 22:30:32 INFO - no previously-included directories found matching '.git*' 22:30:32 INFO - Successfully installed jsonschema functools32 22:30:32 INFO - Cleaning up... 22:30:32 INFO - Return code: 0 22:30:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:32 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:32 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 22:30:32 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 22:30:32 INFO - Using env: {'DISPLAY': ':0', 22:30:32 INFO - 'HOME': '/home/cltbld', 22:30:32 INFO - 'LANG': 'en_US.UTF-8', 22:30:32 INFO - 'LANGUAGE': 'en_US:en', 22:30:32 INFO - 'LOGNAME': 'cltbld', 22:30:32 INFO - 'MAIL': '/var/mail/cltbld', 22:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:32 INFO - 'MOZ_NO_REMOTE': '1', 22:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:32 INFO - 'NO_EM_RESTART': '1', 22:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:32 INFO - 'PWD': '/builds/slave/test', 22:30:32 INFO - 'SHELL': '/bin/bash', 22:30:32 INFO - 'SHLVL': '1', 22:30:32 INFO - 'TERM': 'linux', 22:30:32 INFO - 'TMOUT': '86400', 22:30:32 INFO - 'USER': 'cltbld', 22:30:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:32 INFO - '_': '/tools/buildbot/bin/python'} 22:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:30:32 INFO - Cleaning up... 22:30:32 INFO - Return code: 0 22:30:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:32 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:32 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 22:30:32 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 22:30:32 INFO - Using env: {'DISPLAY': ':0', 22:30:32 INFO - 'HOME': '/home/cltbld', 22:30:32 INFO - 'LANG': 'en_US.UTF-8', 22:30:32 INFO - 'LANGUAGE': 'en_US:en', 22:30:32 INFO - 'LOGNAME': 'cltbld', 22:30:32 INFO - 'MAIL': '/var/mail/cltbld', 22:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:32 INFO - 'MOZ_NO_REMOTE': '1', 22:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:32 INFO - 'NO_EM_RESTART': '1', 22:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:32 INFO - 'PWD': '/builds/slave/test', 22:30:32 INFO - 'SHELL': '/bin/bash', 22:30:32 INFO - 'SHLVL': '1', 22:30:32 INFO - 'TERM': 'linux', 22:30:32 INFO - 'TMOUT': '86400', 22:30:32 INFO - 'USER': 'cltbld', 22:30:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:32 INFO - '_': '/tools/buildbot/bin/python'} 22:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:32 INFO - Downloading/unpacking blobuploader==1.2.4 22:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:32 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 22:30:32 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 22:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:34 INFO - Downloading blobuploader-1.2.4.tar.gz 22:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:30:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:30:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:35 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 22:30:35 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 22:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:35 INFO - Downloading docopt-0.6.1.tar.gz 22:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:30:35 INFO - Installing collected packages: blobuploader, requests, docopt 22:30:35 INFO - Running setup.py install for blobuploader 22:30:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:30:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:30:35 INFO - Running setup.py install for requests 22:30:35 INFO - Running setup.py install for docopt 22:30:36 INFO - Successfully installed blobuploader requests docopt 22:30:36 INFO - Cleaning up... 22:30:36 INFO - Return code: 0 22:30:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:36 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')]} 22:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:36 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')]} 22:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:36 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:36 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 22:30:36 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 22:30:36 INFO - Using env: {'DISPLAY': ':0', 22:30:36 INFO - 'HOME': '/home/cltbld', 22:30:36 INFO - 'LANG': 'en_US.UTF-8', 22:30:36 INFO - 'LANGUAGE': 'en_US:en', 22:30:36 INFO - 'LOGNAME': 'cltbld', 22:30:36 INFO - 'MAIL': '/var/mail/cltbld', 22:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:36 INFO - 'MOZ_NO_REMOTE': '1', 22:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:36 INFO - 'NO_EM_RESTART': '1', 22:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:36 INFO - 'PWD': '/builds/slave/test', 22:30:36 INFO - 'SHELL': '/bin/bash', 22:30:36 INFO - 'SHLVL': '1', 22:30:36 INFO - 'TERM': 'linux', 22:30:36 INFO - 'TMOUT': '86400', 22:30:36 INFO - 'USER': 'cltbld', 22:30:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:36 INFO - '_': '/tools/buildbot/bin/python'} 22:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:36 INFO - Running setup.py (path:/tmp/pip-VM_wqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:36 INFO - Running setup.py (path:/tmp/pip-PrrjKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:36 INFO - Running setup.py (path:/tmp/pip-l2JXKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:36 INFO - Running setup.py (path:/tmp/pip-OKKiEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:36 INFO - Running setup.py (path:/tmp/pip-nsxjuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:36 INFO - Running setup.py (path:/tmp/pip-TYJV36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:36 INFO - Running setup.py (path:/tmp/pip-AFx_so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:36 INFO - Running setup.py (path:/tmp/pip-fC6qDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:36 INFO - Running setup.py (path:/tmp/pip-hrAvWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:36 INFO - Running setup.py (path:/tmp/pip-qKLsNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:37 INFO - Running setup.py (path:/tmp/pip-56Dmy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:37 INFO - Running setup.py (path:/tmp/pip-maqaWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:37 INFO - Running setup.py (path:/tmp/pip-_pSATd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:37 INFO - Running setup.py (path:/tmp/pip-SxatiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:37 INFO - Running setup.py (path:/tmp/pip-lLP3qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:37 INFO - Running setup.py (path:/tmp/pip-CWiZW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:37 INFO - Running setup.py (path:/tmp/pip-xg0kVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:30:37 INFO - Running setup.py install for manifestparser 22:30:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:30:37 INFO - Running setup.py install for mozcrash 22:30:37 INFO - Running setup.py install for mozdebug 22:30:37 INFO - Running setup.py install for mozdevice 22:30:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:30:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:30:37 INFO - Running setup.py install for mozfile 22:30:38 INFO - Running setup.py install for mozhttpd 22:30:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Running setup.py install for mozinfo 22:30:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Running setup.py install for mozInstall 22:30:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Running setup.py install for mozleak 22:30:38 INFO - Running setup.py install for mozlog 22:30:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Running setup.py install for moznetwork 22:30:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Running setup.py install for mozprocess 22:30:38 INFO - Running setup.py install for mozprofile 22:30:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:30:38 INFO - Running setup.py install for mozrunner 22:30:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:30:39 INFO - Running setup.py install for mozscreenshot 22:30:39 INFO - Running setup.py install for moztest 22:30:39 INFO - Running setup.py install for mozversion 22:30:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:30:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:30:39 INFO - Cleaning up... 22:30:39 INFO - Return code: 0 22:30:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:39 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:39 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 22:30:39 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 22:30:39 INFO - Using env: {'DISPLAY': ':0', 22:30:39 INFO - 'HOME': '/home/cltbld', 22:30:39 INFO - 'LANG': 'en_US.UTF-8', 22:30:39 INFO - 'LANGUAGE': 'en_US:en', 22:30:39 INFO - 'LOGNAME': 'cltbld', 22:30:39 INFO - 'MAIL': '/var/mail/cltbld', 22:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:39 INFO - 'MOZ_NO_REMOTE': '1', 22:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:39 INFO - 'NO_EM_RESTART': '1', 22:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:39 INFO - 'PWD': '/builds/slave/test', 22:30:39 INFO - 'SHELL': '/bin/bash', 22:30:39 INFO - 'SHLVL': '1', 22:30:39 INFO - 'TERM': 'linux', 22:30:39 INFO - 'TMOUT': '86400', 22:30:39 INFO - 'USER': 'cltbld', 22:30:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:39 INFO - '_': '/tools/buildbot/bin/python'} 22:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:39 INFO - Running setup.py (path:/tmp/pip-6MXX3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:39 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)) 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:39 INFO - Running setup.py (path:/tmp/pip-6mletT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:39 INFO - Running setup.py (path:/tmp/pip-BYHdlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:39 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)) 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:39 INFO - Running setup.py (path:/tmp/pip-uZ5f0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:39 INFO - Running setup.py (path:/tmp/pip-7ht1GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:39 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)) 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:39 INFO - Running setup.py (path:/tmp/pip-WGND9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:39 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)) 22:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:39 INFO - Running setup.py (path:/tmp/pip-incor3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:40 INFO - Running setup.py (path:/tmp/pip-3gJurX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:40 INFO - Running setup.py (path:/tmp/pip-cHI5tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:40 INFO - Running setup.py (path:/tmp/pip-ShoCgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:40 INFO - Running setup.py (path:/tmp/pip-BnGngx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:40 INFO - Running setup.py (path:/tmp/pip-Hpwt_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:40 INFO - Running setup.py (path:/tmp/pip-5vASKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:40 INFO - Running setup.py (path:/tmp/pip-TMDKBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:40 INFO - Running setup.py (path:/tmp/pip-lHGgeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:40 INFO - Running setup.py (path:/tmp/pip-7u_d1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:40 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)) 22:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:40 INFO - Running setup.py (path:/tmp/pip-Scfocv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:40 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)) 22:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:40 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)) 22:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:30:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:30:40 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 22:30:40 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 22:30:40 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 22:30:40 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 22:30:40 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 22:30:40 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 22:30:42 INFO - Downloading blessings-1.6.tar.gz 22:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:30:42 INFO - Installing collected packages: blessings 22:30:42 INFO - Running setup.py install for blessings 22:30:42 INFO - Successfully installed blessings 22:30:42 INFO - Cleaning up... 22:30:42 INFO - Return code: 0 22:30:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:30:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:43 INFO - Reading from file tmpfile_stdout 22:30:43 INFO - Current package versions: 22:30:43 INFO - argparse == 1.2.1 22:30:43 INFO - blessings == 1.6 22:30:43 INFO - blobuploader == 1.2.4 22:30:43 INFO - docopt == 0.6.1 22:30:43 INFO - functools32 == 3.2.3-2 22:30:43 INFO - jsonschema == 2.5.1 22:30:43 INFO - manifestparser == 1.1 22:30:43 INFO - mozInstall == 1.12 22:30:43 INFO - mozcrash == 0.17 22:30:43 INFO - mozdebug == 0.1 22:30:43 INFO - mozdevice == 0.48 22:30:43 INFO - mozfile == 1.2 22:30:43 INFO - mozhttpd == 0.7 22:30:43 INFO - mozinfo == 0.9 22:30:43 INFO - mozleak == 0.1 22:30:43 INFO - mozlog == 3.4 22:30:43 INFO - moznetwork == 0.27 22:30:43 INFO - mozprocess == 0.23 22:30:43 INFO - mozprofile == 0.28 22:30:43 INFO - mozrunner == 6.12 22:30:43 INFO - mozscreenshot == 0.1 22:30:43 INFO - mozsystemmonitor == 0.3 22:30:43 INFO - moztest == 0.7 22:30:43 INFO - mozversion == 1.4 22:30:43 INFO - psutil == 3.1.1 22:30:43 INFO - requests == 1.2.3 22:30:43 INFO - wsgiref == 0.1.2 22:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:43 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')]} 22:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:43 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')]} 22:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:43 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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:43 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 22:30:43 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 22:30:43 INFO - Using env: {'DISPLAY': ':0', 22:30:43 INFO - 'HOME': '/home/cltbld', 22:30:43 INFO - 'LANG': 'en_US.UTF-8', 22:30:43 INFO - 'LANGUAGE': 'en_US:en', 22:30:43 INFO - 'LOGNAME': 'cltbld', 22:30:43 INFO - 'MAIL': '/var/mail/cltbld', 22:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:43 INFO - 'MOZ_NO_REMOTE': '1', 22:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:43 INFO - 'NO_EM_RESTART': '1', 22:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:43 INFO - 'PWD': '/builds/slave/test', 22:30:43 INFO - 'SHELL': '/bin/bash', 22:30:43 INFO - 'SHLVL': '1', 22:30:43 INFO - 'TERM': 'linux', 22:30:43 INFO - 'TMOUT': '86400', 22:30:43 INFO - 'USER': 'cltbld', 22:30:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:43 INFO - '_': '/tools/buildbot/bin/python'} 22:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 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)) 22:30:43 INFO - Cleaning up... 22:30:43 INFO - Return code: 0 22:30:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:30:43 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')]} 22:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:43 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')]} 22:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f0f1687ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1accca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', '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 22:30:43 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 22:30:43 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 22:30:43 INFO - Using env: {'DISPLAY': ':0', 22:30:43 INFO - 'HOME': '/home/cltbld', 22:30:43 INFO - 'LANG': 'en_US.UTF-8', 22:30:43 INFO - 'LANGUAGE': 'en_US:en', 22:30:43 INFO - 'LOGNAME': 'cltbld', 22:30:43 INFO - 'MAIL': '/var/mail/cltbld', 22:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:43 INFO - 'MOZ_NO_REMOTE': '1', 22:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:43 INFO - 'NO_EM_RESTART': '1', 22:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:43 INFO - 'PWD': '/builds/slave/test', 22:30:43 INFO - 'SHELL': '/bin/bash', 22:30:43 INFO - 'SHLVL': '1', 22:30:43 INFO - 'TERM': 'linux', 22:30:43 INFO - 'TMOUT': '86400', 22:30:43 INFO - 'USER': 'cltbld', 22:30:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:43 INFO - '_': '/tools/buildbot/bin/python'} 22:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:30:43 INFO - Cleaning up... 22:30:43 INFO - Return code: 0 22:30:43 INFO - Running post-action listener: _resource_record_post_action 22:30:43 INFO - Running post-action listener: _start_resource_monitoring 22:30:43 INFO - Starting resource monitoring. 22:30:43 INFO - [mozharness: 2016-10-06 05:30:43.669108Z] Finished create-virtualenv step (success) 22:30:43 INFO - [mozharness: 2016-10-06 05:30:43.669676Z] Running install step. 22:30:43 INFO - Running pre-action listener: _resource_record_pre_action 22:30:43 INFO - Running main action method: install 22:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:43 INFO - Reading from file tmpfile_stdout 22:30:43 INFO - Detecting whether we're running mozinstall >=1.0... 22:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:30:43 INFO - Reading from file tmpfile_stdout 22:30:43 INFO - Output received: 22:30:43 INFO - Usage: mozinstall [options] installer 22:30:43 INFO - Options: 22:30:43 INFO - -h, --help show this help message and exit 22:30:43 INFO - -d DEST, --destination=DEST 22:30:43 INFO - Directory to install application into. [default: 22:30:43 INFO - "/builds/slave/test"] 22:30:43 INFO - --app=APP Application being installed. [default: firefox] 22:30:43 INFO - mkdir: /builds/slave/test/build/application 22:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:31:00 INFO - Reading from file tmpfile_stdout 22:31:00 INFO - Output received: 22:31:00 INFO - /builds/slave/test/build/application/firefox/firefox 22:31:00 INFO - Running post-action listener: _resource_record_post_action 22:31:00 INFO - [mozharness: 2016-10-06 05:31:00.121866Z] Finished install step (success) 22:31:00 INFO - [mozharness: 2016-10-06 05:31:00.122110Z] Running run-tests step. 22:31:00 INFO - Running pre-action listener: _resource_record_pre_action 22:31:00 INFO - Running main action method: run_tests 22:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:31:00 INFO - Python 2.7.3 22:31:00 INFO - Return code: 0 22:31:00 INFO - grabbing minidump binary from tooltool 22:31:00 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')]} 22:31:00 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 0x1ac9f60>, '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 0x1acad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:31:00 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 22:31:00 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 22:31:00 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 22:31:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:31:00 INFO - Return code: 0 22:31:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:31:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:31:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:31:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:31:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 22:31:00 INFO - Using env: {'DISPLAY': ':0', 22:31:00 INFO - 'HOME': '/home/cltbld', 22:31:00 INFO - 'LANG': 'en_US.UTF-8', 22:31:00 INFO - 'LANGUAGE': 'en_US:en', 22:31:00 INFO - 'LOGNAME': 'cltbld', 22:31:00 INFO - 'MAIL': '/var/mail/cltbld', 22:31:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:31:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:00 INFO - 'MOZ_NO_REMOTE': '1', 22:31:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:00 INFO - 'NO_EM_RESTART': '1', 22:31:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:00 INFO - 'PWD': '/builds/slave/test', 22:31:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:31:00 INFO - 'SHELL': '/bin/bash', 22:31:00 INFO - 'SHLVL': '1', 22:31:00 INFO - 'TERM': 'linux', 22:31:00 INFO - 'TMOUT': '86400', 22:31:00 INFO - 'USER': 'cltbld', 22:31:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215', 22:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:00 INFO - '_': '/tools/buildbot/bin/python'} 22:31:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:31:00 INFO - mozversion application_buildid: 20161005205900 22:31:00 INFO - mozversion application_changeset: 2273369348da5bb61af45c743ebe0faff1321d3e 22:31:00 INFO - mozversion application_display_name: Nightly 22:31:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:31:00 INFO - mozversion application_name: Firefox 22:31:00 INFO - mozversion application_remotingname: firefox 22:31:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:31:00 INFO - mozversion application_vendor: Mozilla 22:31:00 INFO - mozversion application_version: 52.0a1 22:31:00 INFO - mozversion platform_buildid: 20161005205900 22:31:00 INFO - mozversion platform_changeset: 2273369348da5bb61af45c743ebe0faff1321d3e 22:31:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:31:00 INFO - mozversion platform_version: 52.0a1 22:31:00 INFO - using testdate: 1475731860 22:31:00 INFO - actual date: 1475731860 22:31:00 INFO - starting webserver on 'localhost:58791' 22:31:00 INFO - SUITE-START | Running 2 tests 22:31:00 INFO - TEST-START | dromaeo_css 22:31:00 INFO - operating with platform_type : linux_ 22:31:00 INFO - Initialising browser for dromaeo_css test... 22:31:00 INFO - TEST-INFO | started process 29767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5nDyqQ/profile http://localhost:58791/getInfo.html) 22:31:04 INFO - PROCESS | 29767 | __metrics Screen width/height:1600/1200 22:31:04 INFO - PROCESS | 29767 | colorDepth:24 22:31:04 INFO - PROCESS | 29767 | Browser inner width/height: 1024/697 22:31:04 INFO - PROCESS | 29767 | __metrics 22:31:05 INFO - PROCESS | 29767 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:31:05 INFO - PROCESS | 29767 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:31:05 INFO - PROCESS | 29767 | console.error: PushService: 22:31:05 INFO - PROCESS | 29767 | stateChangeProcessEnqueue: Error transitioning state 22:31:05 INFO - PROCESS | 29767 | UnknownError 22:31:06 INFO - TEST-INFO | 29767: exit 0 22:31:06 INFO - Browser initialized. 22:31:06 INFO - Running cycle 1/1 for dromaeo_css test... 22:31:06 INFO - TEST-INFO | started process 29851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5nDyqQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:18 INFO - PROCESS | 29851 | RSS: Main: 174817280 22:31:18 INFO - PROCESS | 29851 | 22:32:09 INFO - PROCESS | 29851 | 1475731929776 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] 22:34:23 INFO - PROCESS | 29851 | Cycle 1(1): loaded http://localhost:58791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58791/tests/dromaeo/cssquery-ext.html) 22:34:25 INFO - PROCESS | 29851 | RSS: Main: 348098560 22:34:25 INFO - PROCESS | 29851 | 22:37:28 INFO - PROCESS | 29851 | Cycle 1(1): loaded http://localhost:58791/tests/dromaeo/cssquery-ext.html (next: http://localhost:58791/tests/dromaeo/cssquery-jquery.html) 22:37:29 INFO - PROCESS | 29851 | RSS: Main: 275628032 22:37:29 INFO - PROCESS | 29851 | 22:40:31 INFO - PROCESS | 29851 | Cycle 1(1): loaded http://localhost:58791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58791/tests/dromaeo/cssquery-mootools.html) 22:40:31 INFO - PROCESS | 29851 | RSS: Main: 261357568 22:40:31 INFO - PROCESS | 29851 | 22:43:34 INFO - PROCESS | 29851 | Cycle 1(1): loaded http://localhost:58791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58791/tests/dromaeo/cssquery-prototype.html) 22:43:34 INFO - PROCESS | 29851 | RSS: Main: 219918336 22:43:34 INFO - PROCESS | 29851 | 22:46:37 INFO - PROCESS | 29851 | Cycle 1(1): loaded http://localhost:58791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58791/tests/dromaeo/cssquery-yui.html) 22:46:38 INFO - PROCESS | 29851 | RSS: Main: 220545024 22:46:38 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | Cycle 1(1): loaded http://localhost:58791/tests/dromaeo/cssquery-yui.html (next: http://localhost:58791/tests/dromaeo/cssquery-dojo.html) 22:49:41 INFO - PROCESS | 29851 | RSS: Main: 306221056 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | __start_tp_report 22:49:41 INFO - PROCESS | 29851 | _x_x_mozilla_page_load 22:49:41 INFO - PROCESS | 29851 | _x_x_mozilla_page_load_details 22:49:41 INFO - PROCESS | 29851 | |i|pagename|runs| 22:49:41 INFO - PROCESS | 29851 | |0;dojo.html;2591.676040494938;2624.186502184322;2628.500584888871;2656.614790855326;2671.625972363868;4514.796834142463;4611.239145540982;4713.481517033128;4726.19654658708;4765.166095933211;4639.164950308943;4661.4639316478615;4713.057388522292;4742.193827049401;4799.520047995199;4244.469441319835;4247.15056988602;4284.785760711968;4308.18144552534;4316;4137.379393091045;4419.889502762425;4441.888952776174;4458.531854155316;4502.392177056088;4193.937090943638;4334.739915605074;4362.389265502832;4421.6904816662845;4469.977650111745;4221.493420789494;4274.829006839723;4341.869743907688;4384.561543845622;4404.911901761979;4354.738715677069;4362.934555981663;4366.868993930188;4418.1384629997165;4424.247877860771;4744.501827308152;4751.572358487752;4771.188897887368;4778.713277203379;4782.569568738831;4829.806807727722;4875.902481950377;5059.443461219263;5087.745612719349;5101.311322971388;5154.974225128888;5158.690478571298;5159.071367153911;5191.740412979374;5206.531412172884;4809.831655892027;4811.975940120277;4811.975940120277;4815.036992601424;4873.780679869415;5082.593392528589;5089.770960306795;5158.432572417031;5223.764930578133;5230.004392444988;4965.975170124127;4981.501849814989;4997.925031124536;5044.268581055726;5049.444561098277;5046.369203849519;5052.191649336089;5052.444231134572;5053.166227572409;5114.923276150861;4846.80612775492;4905.533974272438;5004.374453193351;5011.899762004739;5015.097282489114;4924.901501969941;4951.10880041596;4966.404031516169;4985.900281994413;4987.4015118185325;4211.031462763582;4275.40144379787;4305.9569404306185;4324.589164029412;4380.846670366585;3705.5923848377197;3781.6785573226034;3786.413105968579;3830.904227394282;3836.961630383716;4386.298192289282;4395.7362558246605;4398.252297109499;4399.340098985178;4451.087527056946;4936.111499930047;4990.051890140861;5053.823116190915;5103.10695628271;5120.564751996122;4403.075354175595;4409.625181859514;4411.161879242998;4415.492218394861;4462.821487140478;4583.197940360424;4618.168729628699;4620.099080679235;4622.075584883037;4654.25531914892;4578.587927086578;4624.583787459145;4698.530146985274;4736.360591320127;4741.976290118528;5070.264811602371;5076.517730815566;5098.388193416814;5131;5138.357705286689;4739.218029025173;4747.976260118678;4753.405824271966;4760;4796.160671882337;4922.8769280768265;4974.154393752999;4982.526659967442;4986.351774269322;5045.974770126126;5050.545450909436;5105.744712764421;5106.412762532356;5111.131107711623;5115.769790359368;4999.999999999942;5001.399832020181;5007.574356179765;5009.924851127309;5011.323471331323;4955.677880937727;4960.330355401975;4976.950230497649;4979.676321039121;4980.153373926513;4722.126406614787;4806.47128815837;4806.663533552758;4807.879803004953;4868.902621947612;4893.584045356185;4896.143174944442;4900.362952816111;4902.3872015998;4941.50584941503;4596.356510088657;4634.86095417138;4643.512431194676;4725.1967165581245;4775.498572649822 22:49:41 INFO - PROCESS | 29851 | |1;ext.html;539.1965970703651;549.7471163264898;554.1908813132826;565.5051829649055;566.8271177290927;26991.730082699192;36802;38329.616703832915;38435.23129537414;42181.15637687252;39727.40408893869;40161.59838401615;40215.396769048486;40224.39663405044;40249.39625905606;7090.787276381691;7298.197198308195;7470.514416562934;7473.327400533951;7479.326860582546;7119.85760284794;7356.558606483628;7361.6319184040585;9649.324547281693;9916.801663966717;9997.300188986774;10072;10081.747956301078;10086.798264034715;10106.949465252663;9893.25800564957;9950.253730970206;9966.053224943691;9970.102690757867;9972.850407243825;9710.757231069209;9768.21854251658;9769.706908792748;9777.853332199951;9786.657466988692;37266.81366593177;37576;37649.62350376489;37671.4349284761;37672.62327376719;2904.143277733074;2956.807807492506;2974.5835583018393;2996.925076873074;3046.436409264293;28301.433971320665;28386.148415547566;28832.567511487345;28930.42139157205;30228.69771302303;3450.5065785545135;3495.9825200873834;3508.3684936711384;3539.823008849573;3589.425691889311;250777;250944;251524;251759;252197;31069.844650777053;32120.678793212235;52400.73799630978;52835.471645283826;52910;33675.32649346999;33981.320373592884;34017.31965360679;34023.489647655304;34026.829865850515;12522.74954500923;12669.619911402673;12711.237325760483;12742.936285318514;12766.61700148997;10473.319234249902;10731.946340268405;10733.892661073289;10736.355818650905;10738.409387483607;7317.085364329459;7465.440091993122;7560.130584982798;7852.254035866584;7952.085510166405;3113.252819323346;3117.06488053583;3160.261855979202;3168.8257145856737;3170.461021626329;835.2774849754918;866.0386970462781;871.4422769427572;892.6206362296128;917.1104029091771;26744.465110697678;27077.593836092474;27989.720102799118;28177.57733633997;28178.85910570434;908.68650315641;957.4865976810871;977.2475194100645;977.7066879936133;996.4320337407609;14228.217448040457;14902.627434314012;14985.475508357373;15248.847511524742;15307.540773776804;370237;374940;375635;376054;376320;42217.36673949893;42589;47228.7638561805;48275.517244827104;48295.5170448298;1138.692553010699;1143.7140714821294;1166.067146282987;1167.3171194851107;1168.0713832503181;27621.171364859085;28556.42887142287;28992;29461;29488.852555737085;42357.36463953105;42921.141577168906;42963.35554966616;42967.355489667054;43004.56995430006;317137;318202;318755;319055;319598;24832.875835620707;25016.124435644666;25401.110961116272;25461.61807572925;25491.36271593225;40522.797386012884;41037;41285;41514.58485415107;41581;34473.827630861684;34988.65011349854;35042.824785875906;35705.46441803323;35834.64165358313;33726.325473490884;34395;35142.648573513936;35152.47271290881;35278.29443411169;34764.652353477155;34800.65199347974;35186.12034699051;35408.46887296744;35963.820180898925;29235.85382073076;31191.376172476877;31538.842305789243;31685.366292673556;31926.68073319237;24538;24833.379165520284;24927.252182434557;25212.24363269105;25375.238742837744 22:49:41 INFO - PROCESS | 29851 | |2;jquery.html;333.7113396911672;348.48946293679757;354.19950910941265;361.2900650222313;373.6114440981378;12478.750424991505;12531.624051278453;12804.103712740112;12904.612861614154;16380;16016.279267432965;16303.918480407581;16456.506304810846;16600.916995415035;16610.916945415254;4886.216530966199;4938.2098864181735;5129.128048231791;5136.614753893455;5165.535101840853;3602.855885764566;4974.502549745032;5081.8475445736685;5084.949150508503;5087.389513258396;3755.117547376364;5642.4357564243455;5906.232189815318;5917.911231331534;6036.849078773022;5458.972705136449;5748.252727145445;6025.668588227646;6027.336992930774;6039.516838652919;5210.739463026834;5216.426193118792;5222.294990176316;5223.242629818655;5225.399079105913;10861.294015888941;11124.888751112467;11192.832107518394;11291.040261577777;11291.548338066468;1931.893745843978;1939.6896496560623;1972.6745087060617;1983.7817840037585;2310.237621584873;8877;9459.054094590554;11508.539658413654;11625.6512304631;13356.532521361803;1717.5019244419104;1755.3154269834774;1763.3387479695114;1781.5457058450143;1783.1351794379716;64968.675156624384;66440.66779666071;66915.3308466914;68144.6592767038;70709;9019.368644194843;9064.328946776566;9143.497107659143;9292.674756383494;9624.278179136592;12879.42042608085;12908;12935.159214651017;12939.5471158509;12957.870421295855;6605.57063790852;6839.589624622538;6920;6962.338577835098;7049.506534542636;6452.9677351612945;6590.637514936724;6622.106015687917;6727.865442691119;6808.8978665320055;4092.324766413568;4111.958880411217;4130.731502452331;4280.379344994958;4318.52496225415;1733.609937763993;1741.9303227870996;1756.920938557768;1762.709152989768;1855.2300795170124;782.2568559868148;824.4270232188571;844.0841686769801;847.317909083194;887.2990337633327;15567.532974010797;15994.36022559108;16375.918120409322;16802.243899024572;17047.573810654834;825.2931571916259;835.2524490580896;853.6414705823569;882.9293656507592;891.9554022298859;7057.505974581833;9222.354435189472;9254.12085851843;9498;9595.952020239854;340423;346313;346928;346997;347814;70665.64667176631;73240.63379683174;74839.62580187064;75233;77217.6139119312;888.0808363343908;891.1934699097327;900.1943260781563;907.26964793342;926.4672813132476;14418.600003996764;14453.277336133362;14644.12135271887;14675.19286439256;15195.696086078438;35757.28485430329;35998.280034399686;36556;36926.815365923;37098.62901370952;47876.28185577149;50248;50583.74708126583;51523.48476515187;52229.47770522246;4777.307290442797;7268.184203293314;7493.625318734151;7597.6201189939175;7864.882026769717;9045.638174472948;11643.767124657628;11696.298222106701;11760.647180584596;11770;9895.25785566071;9947.353422027545;10103.292769506357;10278.486075696335;10831.187660925305;10261.435621040915;10272.537735801758;10273.383596984206;10315.535800888827;10444.791104178026;10279.794404111726;10401.531931063271;10446.164306855586;10638.73403164927;11061.723456913642;6789.796306110825;6925.965370173117;6954.756583519553;7422.146453157956;7511.3615342696485;8995.280377569648;9449.826539896;9938.55276512573;9941.950290248502;10312.381257124596 22:49:41 INFO - PROCESS | 29851 | |3;mootools.html;1218.7988981818;1331.4141777617847;1373.066314905864;1421.268046955818;1676.027814080629;6654.600723956566;7578.734744283951;7800.3369713574275;7857.8035549111155;8021.358291336694;7856.685732570704;7924.167962363956;7924.762257132295;7930.484518506293;7935;2164.4588852786806;2197.3298144066052;2201.108551036825;2204.1293688992837;2204.801567858892;2133.925312614059;2157;2190.6385446401323;2191.9780802192013;2200.4058904095887;2144.1959265275523;2145.495808485005;2147.7315335583053;2160.4166874943835;2197.044285735702;1987.2448469581539;1997.340877510418;1997.9900100499476;1998.0509258102286;2003.6493613617558;2066.5143691232547;2132.338974917765;2132.648113061343;2136.9849321572283;2140.3792900058966;7635.732749353801;7821.921780782176;7829.138794732575;7830.412719046038;7837.412194085467;4476;4642;4646.465656449518;4703.270992996091;4706.623470122382;2810.18504633656;2941.1323659520494;3000.6249218847643;3009.849507524615;3023.68251333609;885.3315746611331;890.3945317184312;892.3129190523325;897.3942588752631;908.8046070094962;10139.847902281472;10144.94927525365;10204.74488137795;10218.693439196762;10232.795344093076;3688.5573731152435;3775.320442320409;3901.0637447012514;3903.4535165076913;4040;8051;8072.556009419421;8077.434579579491;8080.71717489885;8081.595920203967;4543.38664280318;4543.840965566255;4557.065801510682;4559.110973360163;4570.177368073712;3806.1436176859984;3936.8622098226424;4132.090939993197;4242;4269.893252668646;3320.9501857472155;3327.284633803695;3429.091290807938;3431.159365955307;3444.0528854565196;961.6922584772806;962.9133377996014;973.7127547373542;978.3640633588083;979.4759803505233;764.9082110146818;792.4413288631501;799.4843326054778;807.0960524212802;812.7358608452276;4948.158813001726;4956.157453232959;5066.417362003343;5097.464766199496;5311.468853114735;381.0815933600066;385.61631176979085;388.415434770674;398.0645483114657;408.5036680433288;3258.315753691751;3280;3288.3423315337027;3320.1367644412144;3383.4586466165297;9294.86057709135;9567;9663.565139568596;9663.71008869721;9732.41605503672;9320.487373194539;9584.520773961274;9598.136167744937;9601.279904007228;9602.183814375716;7334.413246940232;7344.192138864721;7385.409167266605;7385.4460915431555;7386.926130738624;4763.261694437368;4783.064803451951;4882.389701287339;4882.584980276716;4941.382327209099;8647.221750042527;8785.428947118417;8877.378583499092;8878.067802880605;8911.2425443838;8952.597133128895;9001.639934402812;9057.139571740674;9069.274458043472;9127.817443650956;5696.971515142398;5881.147233651011;6374.713137908898;6430.742770289323;6439.9696048631995;7071.504994650325;7352.264773522605;7361.558306501627;7544.698212071456;7550.056242969629;6560.442362399059;6575.80272591823;6717.9328206719265;6723.596584204964;6724.092247546519;6636.13730215069;6788.9660551696925;6808.217055038734;6926.099607051051;6978.895316570357;6253.593516421418;6315.210598675166;6325.746970121144;6346.714397852015;6374.07575901501;4313.482382114166;4389.078293558388;4450.599446049871;4485.6860019798305;4517.344984977226;4368.890777730582;4465.263231566755;4575.885602859955;4577.771111444348;4710.858674239778 22:49:41 INFO - PROCESS | 29851 | |4;prototype.html;294.4978811127028;298.1027108403705;302.8727934267607;307.5724742607774;309.4847079612444;4875.609951203904;4882;4892.5596696297325;4894.363732714751;4923.852284431464;4838.685485443444;4844.159219496595;4845.563899249067;4854.12625727369;4854.3446634704305;3589.5692516897943;3705.9073523162;3713.554373475187;3823.8661646842365;3827.5215598050245;3802.790846503455;3823.4073718573663;3829.138443850139;3858.4791053207737;3858.74918130322;3787.7159213058994;3797.563280222782;3804.8858534243877;3808.6000969898178;3831.329517334469;3588.8923332300074;3674.1365779041903;3715.6841668458214;3763.929838588765;3813;3309;3336.199312165087;3340.3987282289177;3341.74936879735;3344.715699165574;4652.674312798105;4673.252279635242;4673.644643053511;4684.072454715802;4706.458757242926;4134.958650413488;4299.398084268205;4325.913481730379;4326.334361270902;4330.13397320534;5000.7249601271915;5001.224810154432;5010.498950104997;5011.323471331397;5013.749312534359;3615.9276814463565;3629.2015756533783;3629.8366573504254;3640.7815531067954;3646.762960407565;5180.559652429511;5296.602754793406;5317.006122703986;5335.386430560497;5352.2239275305255;3667.2482141161;3667.88129620463;3685.7051435885064;3686.336459437327;3701.8889433317045;3737.6075512071384;3752;3774.0564858785306;3776.3202623527477;3785.734998550075;4266.978665106717;4278.465191851019;4284.807183676742;4300.956990430056;4310.827566897352;4841.927371089437;4990.4011518618;5022.723750193702;5102.5662818660085;5115.974420127875;1298.8701129886936;1307.744989727013;1314.172071594889;1316.6839958410105;1318.7824009038593;842.6123982967781;859.1580251353583;860.3117505995178;868.8965014431762;874.580201503282;4276.72201306914;4387.517373088957;4419.425474688334;4504.369388285642;4535.888707266741;5196.350456192976;5198.142306519458;5202.869928251824;5203.375594928557;5247.763850626731;4476.753778542212;4479.574440428154;4490.595846373777;4492.73043617384;4502.324651302265;2628.868556572164;2768.1280396674983;2777.6250206222307;2779.9305017374727;2781.4993301205977;4879.878003049881;4883.0223759376795;4891.187567148903;4897.4857639947295;4945.282933974626;5146.87132821675;5285.682859028394;5303.814366497231;5314.016906872241;5342.225377320345;4823.927641085386;4838.927416088762;4852;4877.56101950819;4882.170031094652;5163.6763456444;5174.7930082796265;5179.741012949413;5200.297959775382;5224.242484839601;4994.500549944976;5118.590512759045;5132.948670513397;5157.931031036527;5160.974195129001;4858.95141048585;4881.585065269492;4904.033059998792;4905.264210368473;4906.55840974314;3792.089898424303;3801.1827457096856;3816.160444702161;3844.5770965194365;3844.7116466264583;5129.021031173897;5136.30659860914;5245.632805703564;5247.317848679647;5250.868728281671;5005.22314578334;5016.097102521581;5019.623528235324;5025.472325405926;5043.823466178666;5008.499150084962;5027.2207807789855;5032.521910418504;5062.215356619729;5092.548623642244;4829.7585120743115;4973.850784476472;4977.925331119964;4987.875303117451;4987.875303117451;4790.353302304284;4909.7545122743;4910.94414700841;5077.086124497626;5093.847184584469;4955.45489996093;4962.602991760578;4962.900741985068;4992.552159873596;4993.350864387607 22:49:41 INFO - PROCESS | 29851 | |5;yui.html;615.230961298377;639.6386041886334;639.7345101782761;676.7293082766896;706.9960655868664;12618.24290542568;13599.18404895707;13849.930750346259;13860.792088118673;14133.081349712262;12183.695407614814;12362.443690033948;12376.938115309433;12381.504739810396;12390.194637348588;732.7581897973669;753.8228516298666;758.3857075768617;758.7989182866545;759.1459607941066;608.5192697768757;627.087587560099;738.2396131984038;759.14975227745;764.5412752348574;794.8092457810142;795.1253621016864;797.2585495489193;797.3103265675178;797.9202079792003;764.5565571968245;766.0921807657887;766.3830616353833;766.5745511241231;766.9654865531064;467.05887636412655;474.7127987567541;561.7640590951769;573.3435216676924;578.673049726903;13007.86992130076;13044.217346959213;13085.672858178526;13101.148425352321;13230.073894827367;11981.28112313264;12263.75472490554;12314.322712250823;12428.627141185689;12993.220406775623;11483.311001339946;11532.88467115335;11719.589814356541;11726.765464690743;11951.820722689166;3232.2081090132833;3437.8281085945855;3492.406290930548;3496.4790316212275;4223.915521689549;53114.46885531172;55066.17400738992;55138.89722205573;55737;55832.720836395965;10486.27981998486;10581.788364232672;10622.150227981743;10666.253362264722;10778.892211077946;18577;18600.34898778536;18612.34856780006;18614.627707445776;18720.81279187218;6857.897131543031;6955.304469553004;7005.264447233069;7068.222495525488;7188.856222875514;3686.299603075407;3704.9629503705155;3725.4225595032813;3729.7389182756947;3782;2758.7447711291716;2862.685104638488;2883.68279489256;2889.797714160031;2893.8697758600915;504.4148787406664;509.4574278393499;510.90037442698315;514.5497689521668;527.933574180154;491.5477760460385;550.422056840316;614.1862032806459;639.3925770518026;640.9198850143732;8646.827063458695;8913.930328360639;8930.106989301017;8952.597133129026;9006.009338972708;597.6384287505996;617.299365220469;618.1099217127322;618.5144661440747;619.9225096862892;3652.470391793175;3733.216024634857;3738.12154143776;3760.6615404613717;3907.5115610548683;52988;78172.21827781764;91931.54034229786;103955.4802225984;104467.47766261273;46970.76514617474;47124;48587.271190932166;72163.6391818048;76361.23638763653;40080;67061.3293867055;68200.65899670668;68826.65586672035;69187;8206.712765053195;9040.728778136667;9109.590068447069;9126.954365228132;9193.315946683177;41017;41908.16183676248;42135;42156.57843421526;43628.34557481704;53761;57542.36864470363;57981;59908.400915990285;62662.686686566274;10996.505157267782;11100.195488870912;11210.531831542505;11335.263207891461;11530.76938461243;12023.879761202626;12455.377231138587;12525.684634770669;12831.679208019874;13461.192328460324;10156.644517441853;11873.881261187624;12111.818322725343;12134.878651213376;12353.876461235273;11622.5350985963;11914.463849126983;11941.82087268709;12261.325627090238;12389.566365177176;12033.699157520781;12197.51209951592;12317.384130793604;12341.75316493683;12373.62879113628;9882.950585247028;9996.850047249443;10005.299629025898;10286.948565257426;10410.791784164427;9898.901010989797;10195.271945119066;10288.639897603547;10289.84565231507;10299.742506437398 22:49:41 INFO - PROCESS | 29851 | __end_tp_report 22:49:41 INFO - PROCESS | 29851 | __start_cc_report 22:49:41 INFO - PROCESS | 29851 | _x_x_mozilla_cycle_collect,1777 22:49:41 INFO - PROCESS | 29851 | __end_cc_report 22:49:41 INFO - PROCESS | 29851 | __startTimestamp1475732981505__endTimestamp 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | ------- Summary: start ------- 22:49:41 INFO - PROCESS | 29851 | Number of tests: 6 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | [#0] dojo.html Cycles:165 Average:4673.01 Median:4778.71 stddev:486.77 (10.2%) stddev-sans-first:460.07 22:49:41 INFO - PROCESS | 29851 | Values: 2591.7 2624.2 2628.5 2656.6 2671.6 4514.8 4611.2 4713.5 4726.2 4765.2 4639.2 4661.5 4713.1 4742.2 4799.5 4244.5 4247.2 4284.8 4308.2 4316.0 4137.4 4419.9 4441.9 4458.5 4502.4 4193.9 4334.7 4362.4 4421.7 4470.0 4221.5 4274.8 4341.9 4384.6 4404.9 4354.7 4362.9 4366.9 4418.1 4424.2 4744.5 4751.6 4771.2 4778.7 4782.6 4829.8 4875.9 5059.4 5087.7 5101.3 5155.0 5158.7 5159.1 5191.7 5206.5 4809.8 4812.0 4812.0 4815.0 4873.8 5082.6 5089.8 5158.4 5223.8 5230.0 4966.0 4981.5 4997.9 5044.3 5049.4 5046.4 5052.2 5052.4 5053.2 5114.9 4846.8 4905.5 5004.4 5011.9 5015.1 4924.9 4951.1 4966.4 4985.9 4987.4 4211.0 4275.4 4306.0 4324.6 4380.8 3705.6 3781.7 3786.4 3830.9 3837.0 4386.3 4395.7 4398.3 4399.3 4451.1 4936.1 4990.1 5053.8 5103.1 5120.6 4403.1 4409.6 4411.2 4415.5 4462.8 4583.2 4618.2 4620.1 4622.1 4654.3 4578.6 4624.6 4698.5 4736.4 4742.0 5070.3 5076.5 5098.4 5131.0 5138.4 4739.2 4748.0 4753.4 4760.0 4796.2 4922.9 4974.2 4982.5 4986.4 5046.0 5050.5 5105.7 5106.4 5111.1 5115.8 5000.0 5001.4 5007.6 5009.9 5011.3 4955.7 4960.3 4977.0 4979.7 4980.2 4722.1 4806.5 4806.7 4807.9 4868.9 4893.6 4896.1 4900.4 4902.4 4941.5 4596.4 4634.9 4643.5 4725.2 4775.5 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | [#1] ext.html Cycles:180 Average:45646.30 Median:19275.60 stddev:84005.80 (435.8%) stddev-sans-first:84173.19 22:49:41 INFO - PROCESS | 29851 | Values: 539.2 549.7 554.2 565.5 566.8 26991.7 36802.0 38329.6 38435.2 42181.2 39727.4 40161.6 40215.4 40224.4 40249.4 7090.8 7298.2 7470.5 7473.3 7479.3 7119.9 7356.6 7361.6 9649.3 9916.8 9997.3 10072.0 10081.7 10086.8 10106.9 9893.3 9950.3 9966.1 9970.1 9972.9 9710.8 9768.2 9769.7 9777.9 9786.7 37266.8 37576.0 37649.6 37671.4 37672.6 2904.1 2956.8 2974.6 2996.9 3046.4 28301.4 28386.1 28832.6 28930.4 30228.7 3450.5 3496.0 3508.4 3539.8 3589.4 250777.0 250944.0 251524.0 251759.0 252197.0 31069.8 32120.7 52400.7 52835.5 52910.0 33675.3 33981.3 34017.3 34023.5 34026.8 12522.7 12669.6 12711.2 12742.9 12766.6 10473.3 10731.9 10733.9 10736.4 10738.4 7317.1 7465.4 7560.1 7852.3 7952.1 3113.3 3117.1 3160.3 3168.8 3170.5 835.3 866.0 871.4 892.6 917.1 26744.5 27077.6 27989.7 28177.6 28178.9 908.7 957.5 977.2 977.7 996.4 14228.2 14902.6 14985.5 15248.8 15307.5 370237.0 374940.0 375635.0 376054.0 376320.0 42217.4 42589.0 47228.8 48275.5 48295.5 1138.7 1143.7 1166.1 1167.3 1168.1 27621.2 28556.4 28992.0 29461.0 29488.9 42357.4 42921.1 42963.4 42967.4 43004.6 317137.0 318202.0 318755.0 319055.0 319598.0 24832.9 25016.1 25401.1 25461.6 25491.4 40522.8 41037.0 41285.0 41514.6 41581.0 34473.8 34988.7 35042.8 35705.5 35834.6 33726.3 34395.0 35142.6 35152.5 35278.3 34764.7 34800.7 35186.1 35408.5 35963.8 29235.9 31191.4 31538.8 31685.4 31926.7 24538.0 24833.4 24927.3 25212.2 25375.2 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | [#2] jquery.html Cycles:180 Average:22418.37 Median:4912.21 stddev:57360.51 (1167.7%) stddev-sans-first:57497.45 22:49:41 INFO - PROCESS | 29851 | Values: 333.7 348.5 354.2 361.3 373.6 12478.8 12531.6 12804.1 12904.6 16380.0 16016.3 16303.9 16456.5 16600.9 16610.9 4886.2 4938.2 5129.1 5136.6 5165.5 3602.9 4974.5 5081.8 5084.9 5087.4 3755.1 5642.4 5906.2 5917.9 6036.8 5459.0 5748.3 6025.7 6027.3 6039.5 5210.7 5216.4 5222.3 5223.2 5225.4 10861.3 11124.9 11192.8 11291.0 11291.5 1931.9 1939.7 1972.7 1983.8 2310.2 8877.0 9459.1 11508.5 11625.7 13356.5 1717.5 1755.3 1763.3 1781.5 1783.1 64968.7 66440.7 66915.3 68144.7 70709.0 9019.4 9064.3 9143.5 9292.7 9624.3 12879.4 12908.0 12935.2 12939.5 12957.9 6605.6 6839.6 6920.0 6962.3 7049.5 6453.0 6590.6 6622.1 6727.9 6808.9 4092.3 4112.0 4130.7 4280.4 4318.5 1733.6 1741.9 1756.9 1762.7 1855.2 782.3 824.4 844.1 847.3 887.3 15567.5 15994.4 16375.9 16802.2 17047.6 825.3 835.3 853.6 882.9 892.0 7057.5 9222.4 9254.1 9498.0 9596.0 340423.0 346313.0 346928.0 346997.0 347814.0 70665.6 73240.6 74839.6 75233.0 77217.6 888.1 891.2 900.2 907.3 926.5 14418.6 14453.3 14644.1 14675.2 15195.7 35757.3 35998.3 36556.0 36926.8 37098.6 47876.3 50248.0 50583.7 51523.5 52229.5 4777.3 7268.2 7493.6 7597.6 7864.9 9045.6 11643.8 11696.3 11760.6 11770.0 9895.3 9947.4 10103.3 10278.5 10831.2 10261.4 10272.5 10273.4 10315.5 10444.8 10279.8 10401.5 10446.2 10638.7 11061.7 6789.8 6926.0 6954.8 7422.1 7511.4 8995.3 9449.8 9938.6 9942.0 10312.4 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | [#3] mootools.html Cycles:180 Average:5001.09 Median:4952.16 stddev:2854.63 (57.6%) stddev-sans-first:2848.48 22:49:41 INFO - PROCESS | 29851 | Values: 1218.8 1331.4 1373.1 1421.3 1676.0 6654.6 7578.7 7800.3 7857.8 8021.4 7856.7 7924.2 7924.8 7930.5 7935.0 2164.5 2197.3 2201.1 2204.1 2204.8 2133.9 2157.0 2190.6 2192.0 2200.4 2144.2 2145.5 2147.7 2160.4 2197.0 1987.2 1997.3 1998.0 1998.1 2003.6 2066.5 2132.3 2132.6 2137.0 2140.4 7635.7 7821.9 7829.1 7830.4 7837.4 4476.0 4642.0 4646.5 4703.3 4706.6 2810.2 2941.1 3000.6 3009.8 3023.7 885.3 890.4 892.3 897.4 908.8 10139.8 10144.9 10204.7 10218.7 10232.8 3688.6 3775.3 3901.1 3903.5 4040.0 8051.0 8072.6 8077.4 8080.7 8081.6 4543.4 4543.8 4557.1 4559.1 4570.2 3806.1 3936.9 4132.1 4242.0 4269.9 3321.0 3327.3 3429.1 3431.2 3444.1 961.7 962.9 973.7 978.4 979.5 764.9 792.4 799.5 807.1 812.7 4948.2 4956.2 5066.4 5097.5 5311.5 381.1 385.6 388.4 398.1 408.5 3258.3 3280.0 3288.3 3320.1 3383.5 9294.9 9567.0 9663.6 9663.7 9732.4 9320.5 9584.5 9598.1 9601.3 9602.2 7334.4 7344.2 7385.4 7385.4 7386.9 4763.3 4783.1 4882.4 4882.6 4941.4 8647.2 8785.4 8877.4 8878.1 8911.2 8952.6 9001.6 9057.1 9069.3 9127.8 5697.0 5881.1 6374.7 6430.7 6440.0 7071.5 7352.3 7361.6 7544.7 7550.1 6560.4 6575.8 6717.9 6723.6 6724.1 6636.1 6789.0 6808.2 6926.1 6978.9 6253.6 6315.2 6325.7 6346.7 6374.1 4313.5 4389.1 4450.6 4485.7 4517.3 4368.9 4465.3 4575.9 4577.8 4710.9 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | [#4] prototype.html Cycles:180 Average:4204.08 Median:4843.04 stddev:1212.20 (25.0%) stddev-sans-first:1179.55 22:49:41 INFO - PROCESS | 29851 | Values: 294.5 298.1 302.9 307.6 309.5 4875.6 4882.0 4892.6 4894.4 4923.9 4838.7 4844.2 4845.6 4854.1 4854.3 3589.6 3705.9 3713.6 3823.9 3827.5 3802.8 3823.4 3829.1 3858.5 3858.7 3787.7 3797.6 3804.9 3808.6 3831.3 3588.9 3674.1 3715.7 3763.9 3813.0 3309.0 3336.2 3340.4 3341.7 3344.7 4652.7 4673.3 4673.6 4684.1 4706.5 4135.0 4299.4 4325.9 4326.3 4330.1 5000.7 5001.2 5010.5 5011.3 5013.7 3615.9 3629.2 3629.8 3640.8 3646.8 5180.6 5296.6 5317.0 5335.4 5352.2 3667.2 3667.9 3685.7 3686.3 3701.9 3737.6 3752.0 3774.1 3776.3 3785.7 4267.0 4278.5 4284.8 4301.0 4310.8 4841.9 4990.4 5022.7 5102.6 5116.0 1298.9 1307.7 1314.2 1316.7 1318.8 842.6 859.2 860.3 868.9 874.6 4276.7 4387.5 4419.4 4504.4 4535.9 5196.4 5198.1 5202.9 5203.4 5247.8 4476.8 4479.6 4490.6 4492.7 4502.3 2628.9 2768.1 2777.6 2779.9 2781.5 4879.9 4883.0 4891.2 4897.5 4945.3 5146.9 5285.7 5303.8 5314.0 5342.2 4823.9 4838.9 4852.0 4877.6 4882.2 5163.7 5174.8 5179.7 5200.3 5224.2 4994.5 5118.6 5132.9 5157.9 5161.0 4859.0 4881.6 4904.0 4905.3 4906.6 3792.1 3801.2 3816.2 3844.6 3844.7 5129.0 5136.3 5245.6 5247.3 5250.9 5005.2 5016.1 5019.6 5025.5 5043.8 5008.5 5027.2 5032.5 5062.2 5092.5 4829.8 4973.9 4977.9 4987.9 4987.9 4790.4 4909.8 4910.9 5077.1 5093.8 4955.5 4962.6 4962.9 4992.6 4993.4 22:49:41 INFO - PROCESS | 29851 | 22:49:41 INFO - PROCESS | 29851 | [#5] yui.html Cycles:180 Average:16110.98 Median:42021.58 stddev:21636.80 (51.5%) stddev-sans-first:21666.21 22:49:41 INFO - PROCESS | 29851 | Values: 615.2 639.6 639.7 676.7 707.0 12618.2 13599.2 13849.9 13860.8 14133.1 12183.7 12362.4 12376.9 12381.5 12390.2 732.8 753.8 758.4 758.8 759.1 608.5 627.1 738.2 759.1 764.5 794.8 795.1 797.3 797.3 797.9 764.6 766.1 766.4 766.6 767.0 467.1 474.7 561.8 573.3 578.7 13007.9 13044.2 13085.7 13101.1 13230.1 11981.3 12263.8 12314.3 12428.6 12993.2 11483.3 11532.9 11719.6 11726.8 11951.8 3232.2 3437.8 3492.4 3496.5 4223.9 53114.5 55066.2 55138.9 55737.0 55832.7 10486.3 10581.8 10622.2 10666.3 10778.9 18577.0 18600.3 18612.3 18614.6 18720.8 6857.9 6955.3 7005.3 7068.2 7188.9 3686.3 3705.0 3725.4 3729.7 3782.0 2758.7 2862.7 2883.7 2889.8 2893.9 504.4 509.5 510.9 514.5 527.9 491.5 550.4 614.2 639.4 640.9 8646.8 8913.9 8930.1 8952.6 9006.0 597.6 617.3 618.1 618.5 619.9 3652.5 3733.2 3738.1 3760.7 3907.5 52988.0 78172.2 91931.5 103955.5 104467.5 46970.8 47124.0 48587.3 72163.6 76361.2 40080.0 67061.3 68200.7 68826.7 69187.0 8206.7 9040.7 9109.6 9127.0 9193.3 41017.0 41908.2 42135.0 42156.6 43628.3 53761.0 57542.4 57981.0 59908.4 62662.7 10996.5 11100.2 11210.5 11335.3 11530.8 12023.9 12455.4 12525.7 12831.7 13461.2 10156.6 11873.9 12111.8 12134.9 12353.9 11622.5 11914.5 11941.8 12261.3 12389.6 12033.7 12197.5 12317.4 12341.8 12373.6 9883.0 9996.9 10005.3 10286.9 10410.8 9898.9 10195.3 10288.6 10289.8 10299.7 22:49:41 INFO - PROCESS | 29851 | -------- Summary: end -------- 22:49:41 INFO - PROCESS | 29851 | 22:49:42 INFO - TEST-INFO | 29851: exit 0 22:49:42 INFO - TEST-OK | dromaeo_css | took 1122077ms 22:49:42 INFO - TEST-START | kraken 22:49:42 INFO - operating with platform_type : linux_ 22:49:42 INFO - Initialising browser for kraken test... 22:49:42 INFO - TEST-INFO | started process 30158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGw0Aa6/profile http://localhost:58791/getInfo.html) 22:49:46 INFO - PROCESS | 30158 | __metrics Screen width/height:1600/1200 22:49:46 INFO - PROCESS | 30158 | colorDepth:24 22:49:46 INFO - PROCESS | 30158 | Browser inner width/height: 1024/697 22:49:46 INFO - PROCESS | 30158 | __metrics 22:49:47 INFO - PROCESS | 30158 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:49:47 INFO - PROCESS | 30158 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:49:47 INFO - PROCESS | 30158 | console.error: PushService: 22:49:47 INFO - PROCESS | 30158 | stateChangeProcessEnqueue: Error transitioning state 22:49:47 INFO - PROCESS | 30158 | UnknownError 22:49:48 INFO - TEST-INFO | 30158: exit 0 22:49:48 INFO - Browser initialized. 22:49:48 INFO - Running cycle 1/1 for kraken test... 22:49:48 INFO - TEST-INFO | started process 30239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGw0Aa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:50:00 INFO - PROCESS | 30239 | RSS: Main: 175181824 22:50:00 INFO - PROCESS | 30239 | 22:50:03 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58791/tests/kraken/driver.html?testName=audio-beat-detection) 22:50:04 INFO - PROCESS | 30239 | RSS: Main: 242630656 22:50:04 INFO - PROCESS | 30239 | 22:50:07 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58791/tests/kraken/driver.html?testName=audio-dft) 22:50:08 INFO - PROCESS | 30239 | RSS: Main: 218882048 22:50:08 INFO - PROCESS | 30239 | 22:50:11 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58791/tests/kraken/driver.html?testName=audio-fft) 22:50:11 INFO - PROCESS | 30239 | RSS: Main: 301785088 22:50:11 INFO - PROCESS | 30239 | 22:50:14 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58791/tests/kraken/driver.html?testName=audio-oscillator) 22:50:14 INFO - PROCESS | 30239 | RSS: Main: 212361216 22:50:14 INFO - PROCESS | 30239 | 22:50:16 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:50:17 INFO - PROCESS | 30239 | RSS: Main: 214831104 22:50:17 INFO - PROCESS | 30239 | 22:50:20 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58791/tests/kraken/driver.html?testName=imaging-darkroom) 22:50:21 INFO - PROCESS | 30239 | RSS: Main: 250740736 22:50:21 INFO - PROCESS | 30239 | 22:50:24 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58791/tests/kraken/driver.html?testName=imaging-desaturate) 22:50:25 INFO - PROCESS | 30239 | RSS: Main: 245129216 22:50:25 INFO - PROCESS | 30239 | 22:50:28 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58791/tests/kraken/driver.html?testName=json-parse-financial) 22:50:29 INFO - PROCESS | 30239 | RSS: Main: 248225792 22:50:29 INFO - PROCESS | 30239 | 22:50:30 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:50:31 INFO - PROCESS | 30239 | RSS: Main: 211075072 22:50:31 INFO - PROCESS | 30239 | 22:50:33 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:50:33 INFO - PROCESS | 30239 | RSS: Main: 218759168 22:50:33 INFO - PROCESS | 30239 | 22:50:35 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:50:36 INFO - PROCESS | 30239 | RSS: Main: 228225024 22:50:36 INFO - PROCESS | 30239 | 22:50:39 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:50:40 INFO - PROCESS | 30239 | RSS: Main: 236376064 22:50:40 INFO - PROCESS | 30239 | 22:50:43 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:50:43 INFO - PROCESS | 30239 | RSS: Main: 233472000 22:50:43 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | Cycle 1(1): loaded http://localhost:58791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58791/tests/kraken/driver.html?testName=ai-astar) 22:50:45 INFO - PROCESS | 30239 | RSS: Main: 284418048 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | __start_tp_report 22:50:45 INFO - PROCESS | 30239 | _x_x_mozilla_page_load 22:50:45 INFO - PROCESS | 30239 | _x_x_mozilla_page_load_details 22:50:45 INFO - PROCESS | 30239 | |i|pagename|runs| 22:50:45 INFO - PROCESS | 30239 | |0;ai-astar;114;115;115;116;115;115;117;116;115;114 22:50:45 INFO - PROCESS | 30239 | |1;audio-beat-detection;152;125;128;170;127;127;126;126;160;125 22:50:45 INFO - PROCESS | 30239 | |2;audio-dft;160;160;161;162;162;160;161;162;160;164 22:50:45 INFO - PROCESS | 30239 | |3;audio-fft;74;75;75;117;78;77;76;77;103;77 22:50:45 INFO - PROCESS | 30239 | |4;audio-oscillator;84;84;123;83;83;83;118;84;83;115 22:50:45 INFO - PROCESS | 30239 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 22:50:45 INFO - PROCESS | 30239 | |6;imaging-darkroom;148;148;148;147;147;147;148;147;146;147 22:50:45 INFO - PROCESS | 30239 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 22:50:45 INFO - PROCESS | 30239 | |8;json-parse-financial;65;64;65;64;66;65;66;65;65;64 22:50:45 INFO - PROCESS | 30239 | |9;json-stringify-tinderbox;65;65;66;65;66;65;66;66;66;66 22:50:45 INFO - PROCESS | 30239 | |10;stanford-crypto-aes;84;83;82;90;83;83;83;83;83;83 22:50:45 INFO - PROCESS | 30239 | |11;stanford-crypto-ccm;141;150;141;138;149;142;160;135;173;153 22:50:45 INFO - PROCESS | 30239 | |12;stanford-crypto-pbkdf2;176;174;181;175;174;177;182;175;177;177 22:50:45 INFO - PROCESS | 30239 | |13;stanford-crypto-sha256-iterative;70;69;74;70;71;69;69;70;69;68 22:50:45 INFO - PROCESS | 30239 | __end_tp_report 22:50:45 INFO - PROCESS | 30239 | __start_cc_report 22:50:45 INFO - PROCESS | 30239 | _x_x_mozilla_cycle_collect,1940 22:50:45 INFO - PROCESS | 30239 | __end_cc_report 22:50:45 INFO - PROCESS | 30239 | __startTimestamp1475733045853__endTimestamp 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | ------- Summary: start ------- 22:50:45 INFO - PROCESS | 30239 | Number of tests: 14 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 22:50:45 INFO - PROCESS | 30239 | Values: 114.0 115.0 115.0 116.0 115.0 115.0 117.0 116.0 115.0 114.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:127.50 stddev:17.17 (13.5%) stddev-sans-first:17.28 22:50:45 INFO - PROCESS | 30239 | Values: 152.0 125.0 128.0 170.0 127.0 127.0 126.0 126.0 160.0 125.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 22:50:45 INFO - PROCESS | 30239 | Values: 160.0 160.0 161.0 162.0 162.0 160.0 161.0 162.0 160.0 164.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:14.71 (19.2%) stddev-sans-first:15.24 22:50:45 INFO - PROCESS | 30239 | Values: 74.0 75.0 75.0 117.0 78.0 77.0 76.0 77.0 103.0 77.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:83.00 stddev:17.13 (20.6%) stddev-sans-first:17.79 22:50:45 INFO - PROCESS | 30239 | Values: 84.0 84.0 123.0 83.0 83.0 83.0 118.0 84.0 83.0 115.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:50:45 INFO - PROCESS | 30239 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 22:50:45 INFO - PROCESS | 30239 | Values: 148.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 22:50:45 INFO - PROCESS | 30239 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:50:45 INFO - PROCESS | 30239 | Values: 65.0 64.0 65.0 64.0 66.0 65.0 66.0 65.0 65.0 64.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:50:45 INFO - PROCESS | 30239 | Values: 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.26 (2.7%) stddev-sans-first:2.40 22:50:45 INFO - PROCESS | 30239 | Values: 84.0 83.0 82.0 90.0 83.0 83.0 83.0 83.0 83.0 83.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:149.50 stddev:11.55 (7.7%) stddev-sans-first:11.96 22:50:45 INFO - PROCESS | 30239 | Values: 141.0 150.0 141.0 138.0 149.0 142.0 160.0 135.0 173.0 153.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:2.74 (1.5%) stddev-sans-first:2.89 22:50:45 INFO - PROCESS | 30239 | Values: 176.0 174.0 181.0 175.0 174.0 177.0 182.0 175.0 177.0 177.0 22:50:45 INFO - PROCESS | 30239 | 22:50:45 INFO - PROCESS | 30239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 22:50:45 INFO - PROCESS | 30239 | Values: 70.0 69.0 74.0 70.0 71.0 69.0 69.0 70.0 69.0 68.0 22:50:45 INFO - PROCESS | 30239 | -------- Summary: end -------- 22:50:45 INFO - PROCESS | 30239 | 22:50:47 INFO - TEST-INFO | 30239: exit 0 22:50:47 INFO - TEST-OK | kraken | took 64931ms 22:50:47 INFO - SUITE-END | took 1187s 22:50:47 INFO - Completed test suite (00:19:47) 22:50:47 INFO - javascript benchmark 22:50:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.676040494938, 2624.186502184322, 2628.500584888871, 2656.614790855326, 2671.625972363868, 4514.796834142463, 4611.239145540982, 4713.481517033128, 4726.19654658708, 4765.166095933211, 4639.164950308943, 4661.4639316478615, 4713.057388522292, 4742.193827049401, 4799.520047995199, 4244.469441319835, 4247.15056988602, 4284.785760711968, 4308.18144552534, 4316.0, 4137.379393091045, 4419.889502762425, 4441.888952776174, 4458.531854155316, 4502.392177056088, 4193.937090943638, 4334.739915605074, 4362.389265502832, 4421.6904816662845, 4469.977650111745, 4221.493420789494, 4274.829006839723, 4341.869743907688, 4384.561543845622, 4404.911901761979, 4354.738715677069, 4362.934555981663, 4366.868993930188, 4418.1384629997165, 4424.247877860771, 4744.501827308152, 4751.572358487752, 4771.188897887368, 4778.713277203379, 4782.569568738831, 4829.806807727722, 4875.902481950377, 5059.443461219263, 5087.745612719349, 5101.311322971388, 5154.974225128888, 5158.690478571298, 5159.071367153911, 5191.740412979374, 5206.531412172884, 4809.831655892027, 4811.975940120277, 4811.975940120277, 4815.036992601424, 4873.780679869415, 5082.593392528589, 5089.770960306795, 5158.432572417031, 5223.764930578133, 5230.004392444988, 4965.975170124127, 4981.501849814989, 4997.925031124536, 5044.268581055726, 5049.444561098277, 5046.369203849519, 5052.191649336089, 5052.444231134572, 5053.166227572409, 5114.923276150861, 4846.80612775492, 4905.533974272438, 5004.374453193351, 5011.899762004739, 5015.097282489114, 4924.901501969941, 4951.10880041596, 4966.404031516169, 4985.900281994413, 4987.4015118185325, 4211.031462763582, 4275.40144379787, 4305.9569404306185, 4324.589164029412, 4380.846670366585, 3705.5923848377197, 3781.6785573226034, 3786.413105968579, 3830.904227394282, 3836.961630383716, 4386.298192289282, 4395.7362558246605, 4398.252297109499, 4399.340098985178, 4451.087527056946, 4936.111499930047, 4990.051890140861, 5053.823116190915, 5103.10695628271, 5120.564751996122, 4403.075354175595, 4409.625181859514, 4411.161879242998, 4415.492218394861, 4462.821487140478, 4583.197940360424, 4618.168729628699, 4620.099080679235, 4622.075584883037, 4654.25531914892, 4578.587927086578, 4624.583787459145, 4698.530146985274, 4736.360591320127, 4741.976290118528, 5070.264811602371, 5076.517730815566, 5098.388193416814, 5131.0, 5138.357705286689, 4739.218029025173, 4747.976260118678, 4753.405824271966, 4760.0, 4796.160671882337, 4922.8769280768265, 4974.154393752999, 4982.526659967442, 4986.351774269322, 5045.974770126126, 5050.545450909436, 5105.744712764421, 5106.412762532356, 5111.131107711623, 5115.769790359368, 4999.999999999942, 5001.399832020181, 5007.574356179765, 5009.924851127309, 5011.323471331323, 4955.677880937727, 4960.330355401975, 4976.950230497649, 4979.676321039121, 4980.153373926513, 4722.126406614787, 4806.47128815837, 4806.663533552758, 4807.879803004953, 4868.902621947612, 4893.584045356185, 4896.143174944442, 4900.362952816111, 4902.3872015998, 4941.50584941503, 4596.356510088657, 4634.86095417138, 4643.512431194676, 4725.1967165581245, 4775.498572649822], "value": 4642.137033446009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.1965970703651, 549.7471163264898, 554.1908813132826, 565.5051829649055, 566.8271177290927, 26991.730082699192, 36802.0, 38329.616703832915, 38435.23129537414, 42181.15637687252, 39727.40408893869, 40161.59838401615, 40215.396769048486, 40224.39663405044, 40249.39625905606, 7090.787276381691, 7298.197198308195, 7470.514416562934, 7473.327400533951, 7479.326860582546, 7119.85760284794, 7356.558606483628, 7361.6319184040585, 9649.324547281693, 9916.801663966717, 9997.300188986774, 10072.0, 10081.747956301078, 10086.798264034715, 10106.949465252663, 9893.25800564957, 9950.253730970206, 9966.053224943691, 9970.102690757867, 9972.850407243825, 9710.757231069209, 9768.21854251658, 9769.706908792748, 9777.853332199951, 9786.657466988692, 37266.81366593177, 37576.0, 37649.62350376489, 37671.4349284761, 37672.62327376719, 2904.143277733074, 2956.807807492506, 2974.5835583018393, 2996.925076873074, 3046.436409264293, 28301.433971320665, 28386.148415547566, 28832.567511487345, 28930.42139157205, 30228.69771302303, 3450.5065785545135, 3495.9825200873834, 3508.3684936711384, 3539.823008849573, 3589.425691889311, 250777.0, 250944.0, 251524.0, 251759.0, 252197.0, 31069.844650777053, 32120.678793212235, 52400.73799630978, 52835.471645283826, 52910.0, 33675.32649346999, 33981.320373592884, 34017.31965360679, 34023.489647655304, 34026.829865850515, 12522.74954500923, 12669.619911402673, 12711.237325760483, 12742.936285318514, 12766.61700148997, 10473.319234249902, 10731.946340268405, 10733.892661073289, 10736.355818650905, 10738.409387483607, 7317.085364329459, 7465.440091993122, 7560.130584982798, 7852.254035866584, 7952.085510166405, 3113.252819323346, 3117.06488053583, 3160.261855979202, 3168.8257145856737, 3170.461021626329, 835.2774849754918, 866.0386970462781, 871.4422769427572, 892.6206362296128, 917.1104029091771, 26744.465110697678, 27077.593836092474, 27989.720102799118, 28177.57733633997, 28178.85910570434, 908.68650315641, 957.4865976810871, 977.2475194100645, 977.7066879936133, 996.4320337407609, 14228.217448040457, 14902.627434314012, 14985.475508357373, 15248.847511524742, 15307.540773776804, 370237.0, 374940.0, 375635.0, 376054.0, 376320.0, 42217.36673949893, 42589.0, 47228.7638561805, 48275.517244827104, 48295.5170448298, 1138.692553010699, 1143.7140714821294, 1166.067146282987, 1167.3171194851107, 1168.0713832503181, 27621.171364859085, 28556.42887142287, 28992.0, 29461.0, 29488.852555737085, 42357.36463953105, 42921.141577168906, 42963.35554966616, 42967.355489667054, 43004.56995430006, 317137.0, 318202.0, 318755.0, 319055.0, 319598.0, 24832.875835620707, 25016.124435644666, 25401.110961116272, 25461.61807572925, 25491.36271593225, 40522.797386012884, 41037.0, 41285.0, 41514.58485415107, 41581.0, 34473.827630861684, 34988.65011349854, 35042.824785875906, 35705.46441803323, 35834.64165358313, 33726.325473490884, 34395.0, 35142.648573513936, 35152.47271290881, 35278.29443411169, 34764.652353477155, 34800.65199347974, 35186.12034699051, 35408.46887296744, 35963.820180898925, 29235.85382073076, 31191.376172476877, 31538.842305789243, 31685.366292673556, 31926.68073319237, 24538.0, 24833.379165520284, 24927.252182434557, 25212.24363269105, 25375.238742837744], "value": 16478.86883609559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.7113396911672, 348.48946293679757, 354.19950910941265, 361.2900650222313, 373.6114440981378, 12478.750424991505, 12531.624051278453, 12804.103712740112, 12904.612861614154, 16380.0, 16016.279267432965, 16303.918480407581, 16456.506304810846, 16600.916995415035, 16610.916945415254, 4886.216530966199, 4938.2098864181735, 5129.128048231791, 5136.614753893455, 5165.535101840853, 3602.855885764566, 4974.502549745032, 5081.8475445736685, 5084.949150508503, 5087.389513258396, 3755.117547376364, 5642.4357564243455, 5906.232189815318, 5917.911231331534, 6036.849078773022, 5458.972705136449, 5748.252727145445, 6025.668588227646, 6027.336992930774, 6039.516838652919, 5210.739463026834, 5216.426193118792, 5222.294990176316, 5223.242629818655, 5225.399079105913, 10861.294015888941, 11124.888751112467, 11192.832107518394, 11291.040261577777, 11291.548338066468, 1931.893745843978, 1939.6896496560623, 1972.6745087060617, 1983.7817840037585, 2310.237621584873, 8877.0, 9459.054094590554, 11508.539658413654, 11625.6512304631, 13356.532521361803, 1717.5019244419104, 1755.3154269834774, 1763.3387479695114, 1781.5457058450143, 1783.1351794379716, 64968.675156624384, 66440.66779666071, 66915.3308466914, 68144.6592767038, 70709.0, 9019.368644194843, 9064.328946776566, 9143.497107659143, 9292.674756383494, 9624.278179136592, 12879.42042608085, 12908.0, 12935.159214651017, 12939.5471158509, 12957.870421295855, 6605.57063790852, 6839.589624622538, 6920.0, 6962.338577835098, 7049.506534542636, 6452.9677351612945, 6590.637514936724, 6622.106015687917, 6727.865442691119, 6808.8978665320055, 4092.324766413568, 4111.958880411217, 4130.731502452331, 4280.379344994958, 4318.52496225415, 1733.609937763993, 1741.9303227870996, 1756.920938557768, 1762.709152989768, 1855.2300795170124, 782.2568559868148, 824.4270232188571, 844.0841686769801, 847.317909083194, 887.2990337633327, 15567.532974010797, 15994.36022559108, 16375.918120409322, 16802.243899024572, 17047.573810654834, 825.2931571916259, 835.2524490580896, 853.6414705823569, 882.9293656507592, 891.9554022298859, 7057.505974581833, 9222.354435189472, 9254.12085851843, 9498.0, 9595.952020239854, 340423.0, 346313.0, 346928.0, 346997.0, 347814.0, 70665.64667176631, 73240.63379683174, 74839.62580187064, 75233.0, 77217.6139119312, 888.0808363343908, 891.1934699097327, 900.1943260781563, 907.26964793342, 926.4672813132476, 14418.600003996764, 14453.277336133362, 14644.12135271887, 14675.19286439256, 15195.696086078438, 35757.28485430329, 35998.280034399686, 36556.0, 36926.815365923, 37098.62901370952, 47876.28185577149, 50248.0, 50583.74708126583, 51523.48476515187, 52229.47770522246, 4777.307290442797, 7268.184203293314, 7493.625318734151, 7597.6201189939175, 7864.882026769717, 9045.638174472948, 11643.767124657628, 11696.298222106701, 11760.647180584596, 11770.0, 9895.25785566071, 9947.353422027545, 10103.292769506357, 10278.486075696335, 10831.187660925305, 10261.435621040915, 10272.537735801758, 10273.383596984206, 10315.535800888827, 10444.791104178026, 10279.794404111726, 10401.531931063271, 10446.164306855586, 10638.73403164927, 11061.723456913642, 6789.796306110825, 6925.965370173117, 6954.756583519553, 7422.146453157956, 7511.3615342696485, 8995.280377569648, 9449.826539896, 9938.55276512573, 9941.950290248502, 10312.381257124596], "value": 7827.651629143538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.7988981818, 1331.4141777617847, 1373.066314905864, 1421.268046955818, 1676.027814080629, 6654.600723956566, 7578.734744283951, 7800.3369713574275, 7857.8035549111155, 8021.358291336694, 7856.685732570704, 7924.167962363956, 7924.762257132295, 7930.484518506293, 7935.0, 2164.4588852786806, 2197.3298144066052, 2201.108551036825, 2204.1293688992837, 2204.801567858892, 2133.925312614059, 2157.0, 2190.6385446401323, 2191.9780802192013, 2200.4058904095887, 2144.1959265275523, 2145.495808485005, 2147.7315335583053, 2160.4166874943835, 2197.044285735702, 1987.2448469581539, 1997.340877510418, 1997.9900100499476, 1998.0509258102286, 2003.6493613617558, 2066.5143691232547, 2132.338974917765, 2132.648113061343, 2136.9849321572283, 2140.3792900058966, 7635.732749353801, 7821.921780782176, 7829.138794732575, 7830.412719046038, 7837.412194085467, 4476.0, 4642.0, 4646.465656449518, 4703.270992996091, 4706.623470122382, 2810.18504633656, 2941.1323659520494, 3000.6249218847643, 3009.849507524615, 3023.68251333609, 885.3315746611331, 890.3945317184312, 892.3129190523325, 897.3942588752631, 908.8046070094962, 10139.847902281472, 10144.94927525365, 10204.74488137795, 10218.693439196762, 10232.795344093076, 3688.5573731152435, 3775.320442320409, 3901.0637447012514, 3903.4535165076913, 4040.0, 8051.0, 8072.556009419421, 8077.434579579491, 8080.71717489885, 8081.595920203967, 4543.38664280318, 4543.840965566255, 4557.065801510682, 4559.110973360163, 4570.177368073712, 3806.1436176859984, 3936.8622098226424, 4132.090939993197, 4242.0, 4269.893252668646, 3320.9501857472155, 3327.284633803695, 3429.091290807938, 3431.159365955307, 3444.0528854565196, 961.6922584772806, 962.9133377996014, 973.7127547373542, 978.3640633588083, 979.4759803505233, 764.9082110146818, 792.4413288631501, 799.4843326054778, 807.0960524212802, 812.7358608452276, 4948.158813001726, 4956.157453232959, 5066.417362003343, 5097.464766199496, 5311.468853114735, 381.0815933600066, 385.61631176979085, 388.415434770674, 398.0645483114657, 408.5036680433288, 3258.315753691751, 3280.0, 3288.3423315337027, 3320.1367644412144, 3383.4586466165297, 9294.86057709135, 9567.0, 9663.565139568596, 9663.71008869721, 9732.41605503672, 9320.487373194539, 9584.520773961274, 9598.136167744937, 9601.279904007228, 9602.183814375716, 7334.413246940232, 7344.192138864721, 7385.409167266605, 7385.4460915431555, 7386.926130738624, 4763.261694437368, 4783.064803451951, 4882.389701287339, 4882.584980276716, 4941.382327209099, 8647.221750042527, 8785.428947118417, 8877.378583499092, 8878.067802880605, 8911.2425443838, 8952.597133128895, 9001.639934402812, 9057.139571740674, 9069.274458043472, 9127.817443650956, 5696.971515142398, 5881.147233651011, 6374.713137908898, 6430.742770289323, 6439.9696048631995, 7071.504994650325, 7352.264773522605, 7361.558306501627, 7544.698212071456, 7550.056242969629, 6560.442362399059, 6575.80272591823, 6717.9328206719265, 6723.596584204964, 6724.092247546519, 6636.13730215069, 6788.9660551696925, 6808.217055038734, 6926.099607051051, 6978.895316570357, 6253.593516421418, 6315.210598675166, 6325.746970121144, 6346.714397852015, 6374.07575901501, 4313.482382114166, 4389.078293558388, 4450.599446049871, 4485.6860019798305, 4517.344984977226, 4368.890777730582, 4465.263231566755, 4575.885602859955, 4577.771111444348, 4710.858674239778], "value": 3928.249101187833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.4978811127028, 298.1027108403705, 302.8727934267607, 307.5724742607774, 309.4847079612444, 4875.609951203904, 4882.0, 4892.5596696297325, 4894.363732714751, 4923.852284431464, 4838.685485443444, 4844.159219496595, 4845.563899249067, 4854.12625727369, 4854.3446634704305, 3589.5692516897943, 3705.9073523162, 3713.554373475187, 3823.8661646842365, 3827.5215598050245, 3802.790846503455, 3823.4073718573663, 3829.138443850139, 3858.4791053207737, 3858.74918130322, 3787.7159213058994, 3797.563280222782, 3804.8858534243877, 3808.6000969898178, 3831.329517334469, 3588.8923332300074, 3674.1365779041903, 3715.6841668458214, 3763.929838588765, 3813.0, 3309.0, 3336.199312165087, 3340.3987282289177, 3341.74936879735, 3344.715699165574, 4652.674312798105, 4673.252279635242, 4673.644643053511, 4684.072454715802, 4706.458757242926, 4134.958650413488, 4299.398084268205, 4325.913481730379, 4326.334361270902, 4330.13397320534, 5000.7249601271915, 5001.224810154432, 5010.498950104997, 5011.323471331397, 5013.749312534359, 3615.9276814463565, 3629.2015756533783, 3629.8366573504254, 3640.7815531067954, 3646.762960407565, 5180.559652429511, 5296.602754793406, 5317.006122703986, 5335.386430560497, 5352.2239275305255, 3667.2482141161, 3667.88129620463, 3685.7051435885064, 3686.336459437327, 3701.8889433317045, 3737.6075512071384, 3752.0, 3774.0564858785306, 3776.3202623527477, 3785.734998550075, 4266.978665106717, 4278.465191851019, 4284.807183676742, 4300.956990430056, 4310.827566897352, 4841.927371089437, 4990.4011518618, 5022.723750193702, 5102.5662818660085, 5115.974420127875, 1298.8701129886936, 1307.744989727013, 1314.172071594889, 1316.6839958410105, 1318.7824009038593, 842.6123982967781, 859.1580251353583, 860.3117505995178, 868.8965014431762, 874.580201503282, 4276.72201306914, 4387.517373088957, 4419.425474688334, 4504.369388285642, 4535.888707266741, 5196.350456192976, 5198.142306519458, 5202.869928251824, 5203.375594928557, 5247.763850626731, 4476.753778542212, 4479.574440428154, 4490.595846373777, 4492.73043617384, 4502.324651302265, 2628.868556572164, 2768.1280396674983, 2777.6250206222307, 2779.9305017374727, 2781.4993301205977, 4879.878003049881, 4883.0223759376795, 4891.187567148903, 4897.4857639947295, 4945.282933974626, 5146.87132821675, 5285.682859028394, 5303.814366497231, 5314.016906872241, 5342.225377320345, 4823.927641085386, 4838.927416088762, 4852.0, 4877.56101950819, 4882.170031094652, 5163.6763456444, 5174.7930082796265, 5179.741012949413, 5200.297959775382, 5224.242484839601, 4994.500549944976, 5118.590512759045, 5132.948670513397, 5157.931031036527, 5160.974195129001, 4858.95141048585, 4881.585065269492, 4904.033059998792, 4905.264210368473, 4906.55840974314, 3792.089898424303, 3801.1827457096856, 3816.160444702161, 3844.5770965194365, 3844.7116466264583, 5129.021031173897, 5136.30659860914, 5245.632805703564, 5247.317848679647, 5250.868728281671, 5005.22314578334, 5016.097102521581, 5019.623528235324, 5025.472325405926, 5043.823466178666, 5008.499150084962, 5027.2207807789855, 5032.521910418504, 5062.215356619729, 5092.548623642244, 4829.7585120743115, 4973.850784476472, 4977.925331119964, 4987.875303117451, 4987.875303117451, 4790.353302304284, 4909.7545122743, 4910.94414700841, 5077.086124497626, 5093.847184584469, 4955.45489996093, 4962.602991760578, 4962.900741985068, 4992.552159873596, 4993.350864387607], "value": 3819.6537288799145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.230961298377, 639.6386041886334, 639.7345101782761, 676.7293082766896, 706.9960655868664, 12618.24290542568, 13599.18404895707, 13849.930750346259, 13860.792088118673, 14133.081349712262, 12183.695407614814, 12362.443690033948, 12376.938115309433, 12381.504739810396, 12390.194637348588, 732.7581897973669, 753.8228516298666, 758.3857075768617, 758.7989182866545, 759.1459607941066, 608.5192697768757, 627.087587560099, 738.2396131984038, 759.14975227745, 764.5412752348574, 794.8092457810142, 795.1253621016864, 797.2585495489193, 797.3103265675178, 797.9202079792003, 764.5565571968245, 766.0921807657887, 766.3830616353833, 766.5745511241231, 766.9654865531064, 467.05887636412655, 474.7127987567541, 561.7640590951769, 573.3435216676924, 578.673049726903, 13007.86992130076, 13044.217346959213, 13085.672858178526, 13101.148425352321, 13230.073894827367, 11981.28112313264, 12263.75472490554, 12314.322712250823, 12428.627141185689, 12993.220406775623, 11483.311001339946, 11532.88467115335, 11719.589814356541, 11726.765464690743, 11951.820722689166, 3232.2081090132833, 3437.8281085945855, 3492.406290930548, 3496.4790316212275, 4223.915521689549, 53114.46885531172, 55066.17400738992, 55138.89722205573, 55737.0, 55832.720836395965, 10486.27981998486, 10581.788364232672, 10622.150227981743, 10666.253362264722, 10778.892211077946, 18577.0, 18600.34898778536, 18612.34856780006, 18614.627707445776, 18720.81279187218, 6857.897131543031, 6955.304469553004, 7005.264447233069, 7068.222495525488, 7188.856222875514, 3686.299603075407, 3704.9629503705155, 3725.4225595032813, 3729.7389182756947, 3782.0, 2758.7447711291716, 2862.685104638488, 2883.68279489256, 2889.797714160031, 2893.8697758600915, 504.4148787406664, 509.4574278393499, 510.90037442698315, 514.5497689521668, 527.933574180154, 491.5477760460385, 550.422056840316, 614.1862032806459, 639.3925770518026, 640.9198850143732, 8646.827063458695, 8913.930328360639, 8930.106989301017, 8952.597133129026, 9006.009338972708, 597.6384287505996, 617.299365220469, 618.1099217127322, 618.5144661440747, 619.9225096862892, 3652.470391793175, 3733.216024634857, 3738.12154143776, 3760.6615404613717, 3907.5115610548683, 52988.0, 78172.21827781764, 91931.54034229786, 103955.4802225984, 104467.47766261273, 46970.76514617474, 47124.0, 48587.271190932166, 72163.6391818048, 76361.23638763653, 40080.0, 67061.3293867055, 68200.65899670668, 68826.65586672035, 69187.0, 8206.712765053195, 9040.728778136667, 9109.590068447069, 9126.954365228132, 9193.315946683177, 41017.0, 41908.16183676248, 42135.0, 42156.57843421526, 43628.34557481704, 53761.0, 57542.36864470363, 57981.0, 59908.400915990285, 62662.686686566274, 10996.505157267782, 11100.195488870912, 11210.531831542505, 11335.263207891461, 11530.76938461243, 12023.879761202626, 12455.377231138587, 12525.684634770669, 12831.679208019874, 13461.192328460324, 10156.644517441853, 11873.881261187624, 12111.818322725343, 12134.878651213376, 12353.876461235273, 11622.5350985963, 11914.463849126983, 11941.82087268709, 12261.325627090238, 12389.566365177176, 12033.699157520781, 12197.51209951592, 12317.384130793604, 12341.75316493683, 12373.62879113628, 9882.950585247028, 9996.850047249443, 10005.299629025898, 10286.948565257426, 10410.791784164427, 9898.901010989797, 10195.271945119066, 10288.639897603547, 10289.84565231507, 10299.742506437398], "value": 6413.833541168925, "unit": "score"}], "name": "dromaeo_css", "value": 6215.044888891733, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 116.0, 115.0, 115.0, 117.0, 116.0, 115.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 128.0, 170.0, 127.0, 127.0, 126.0, 126.0, 160.0, 125.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 162.0, 160.0, 161.0, 162.0, 160.0, 164.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 117.0, 78.0, 77.0, 76.0, 77.0, 103.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 123.0, 83.0, 83.0, 83.0, 118.0, 84.0, 83.0, 115.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0], "value": 147.3, "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, 64.0, 65.0, 64.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 90.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 150.0, 141.0, 138.0, 149.0, 142.0, 160.0, 135.0, 173.0, 153.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 181.0, 175.0, 174.0, 177.0, 182.0, 175.0, 177.0, 177.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 74.0, 70.0, 71.0, 69.0, 69.0, 70.0, 69.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1558.2, "alertThreshold": 2.0}]} 22:50:47 INFO - Return code: 0 22:50:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:50:47 INFO - # TBPL SUCCESS # 22:50:47 INFO - Running post-action listener: _resource_record_post_action 22:50:47 INFO - [mozharness: 2016-10-06 05:50:47.663415Z] Finished run-tests step (success) 22:50:47 INFO - Running post-run listener: _resource_record_post_run 22:50:47 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399024128; Read time: 24; Write time: 292752 22:50:47 INFO - TinderboxPrint: CPU usage
13.0% 22:50:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 22:50:47 INFO - TinderboxPrint: I/O write bytes / time
399,024,128 / 292,752 22:50:47 INFO - TinderboxPrint: CPU idle
8,347.4 (87.0%) 22:50:47 INFO - TinderboxPrint: CPU user
1,203.0 (12.5%) 22:50:47 INFO - TinderboxPrint: Swap in / out
0 / 0 22:50:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106160128; Read time: 0; Write time: 92900 22:50:47 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291930112; Read time: 0; Write time: 199824 22:50:48 INFO - Running post-run listener: _upload_blobber_files 22:50:48 INFO - Blob upload gear active. 22:50:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:50:48 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 22:50:48 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:50:48 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 22:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:49 INFO - (blobuploader) - INFO - Done attempting. 22:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:50 INFO - (blobuploader) - INFO - Done attempting. 22:50:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:50:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:53 INFO - (blobuploader) - INFO - Done attempting. 22:50:53 INFO - (blobuploader) - INFO - Iteration through files over. 22:50:53 INFO - Return code: 0 22:50:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:50:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:50:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8bddca426f6e1404b1ccb2db36127d87e7532adba9d1fb33541fc61a7c4f033830788285e0e6e25bf8a856e18569d7dacba6d71025077d0f6cd7e64b92983c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31fcc9f06691d61810b1c89ddd64105ea73ad5ed046af5f453a6c52d3afbb11724115beec5638950b860422f496e1c15292e371216d730b70ad197d12eb4063", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b517acd8779317a5590b062882504212683b105e349fe22a9c5c3abcab7dfee68ed90cd4d6a8fda9e913e5b80ec82412222d67c3dd09a5e9fdb8f32a27faed1"} 22:50:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:50:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:50:53 INFO - Contents: 22:50:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8bddca426f6e1404b1ccb2db36127d87e7532adba9d1fb33541fc61a7c4f033830788285e0e6e25bf8a856e18569d7dacba6d71025077d0f6cd7e64b92983c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31fcc9f06691d61810b1c89ddd64105ea73ad5ed046af5f453a6c52d3afbb11724115beec5638950b860422f496e1c15292e371216d730b70ad197d12eb4063", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b517acd8779317a5590b062882504212683b105e349fe22a9c5c3abcab7dfee68ed90cd4d6a8fda9e913e5b80ec82412222d67c3dd09a5e9fdb8f32a27faed1"} 22:50:53 INFO - Running post-run listener: copy_logs_to_upload_dir 22:50:53 INFO - Copying logs to upload dir... 22:50:53 INFO - mkdir: /builds/slave/test/build/upload/logs 22:50:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.471344 ========= master_lag: 2.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-05 22:50:55.286232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 22:50:55.291060) ========= 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=62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8bddca426f6e1404b1ccb2db36127d87e7532adba9d1fb33541fc61a7c4f033830788285e0e6e25bf8a856e18569d7dacba6d71025077d0f6cd7e64b92983c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31fcc9f06691d61810b1c89ddd64105ea73ad5ed046af5f453a6c52d3afbb11724115beec5638950b860422f496e1c15292e371216d730b70ad197d12eb4063", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b517acd8779317a5590b062882504212683b105e349fe22a9c5c3abcab7dfee68ed90cd4d6a8fda9e913e5b80ec82412222d67c3dd09a5e9fdb8f32a27faed1"} build_url:https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010499 build_url: 'https://queue.taskcluster.net/v1/task/QWPuVbXUT-GXF_sShQQT9A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8bddca426f6e1404b1ccb2db36127d87e7532adba9d1fb33541fc61a7c4f033830788285e0e6e25bf8a856e18569d7dacba6d71025077d0f6cd7e64b92983c93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31fcc9f06691d61810b1c89ddd64105ea73ad5ed046af5f453a6c52d3afbb11724115beec5638950b860422f496e1c15292e371216d730b70ad197d12eb4063", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b517acd8779317a5590b062882504212683b105e349fe22a9c5c3abcab7dfee68ed90cd4d6a8fda9e913e5b80ec82412222d67c3dd09a5e9fdb8f32a27faed1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 22:50:55.315156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:50:55.315448) ========= 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=62c568580acbfdaac3eec7be000001dc-1475731804.912787-59558215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 22:50:55.364533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 22:50:55.365290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 22:50:55.365576) ========= ========= Total master_lag: 2.31 =========