builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1476471648.5 results: success (0) buildid: 20161014105935 builduid: 83fecc11e4344fcf8a4a1c55c2dbbbe1 revision: 09943651fa859ca1c208a0682e34dd32e7a7d8f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.503402) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.503795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.504225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.536238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.536497) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 12:00:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-10-14 12:00:49 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.643981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.644286) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014479 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.730367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:48.730722) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 09943651fa859ca1c208a0682e34dd32e7a7d8f5 --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 09943651fa859ca1c208a0682e34dd32e7a7d8f5 --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=a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 12:00:49,179 truncating revision to first 12 chars 2016-10-14 12:00:49,179 Setting DEBUG logging. 2016-10-14 12:00:49,179 attempt 1/10 2016-10-14 12:00:49,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/09943651fa85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 12:00:49,524 unpacking tar archive at: autoland-09943651fa85/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:49.429098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:49.429398) ========= script_repo_revision: 09943651fa859ca1c208a0682e34dd32e7a7d8f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:49.429795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:49.430057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 12:00:49.438819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-14 12:00:49.439098) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:00:49 INFO - MultiFileLogger online at 20161014 12:00:49 in /builds/slave/test 12:00:49 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 12:00:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:00:49 INFO - {'append_to_log': False, 12:00:49 INFO - 'base_work_dir': '/builds/slave/test', 12:00:49 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:00:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:00:49 INFO - 'branch': 'Autoland-Non-PGO', 12:00:49 INFO - 'buildbot_json_path': 'buildprops.json', 12:00:49 INFO - 'config_files': ('talos/linux_config.py',), 12:00:49 INFO - 'default_actions': ('clobber', 12:00:49 INFO - 'read-buildbot-config', 12:00:49 INFO - 'download-and-extract', 12:00:49 INFO - 'populate-webroot', 12:00:49 INFO - 'create-virtualenv', 12:00:49 INFO - 'install', 12:00:49 INFO - 'run-tests'), 12:00:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:00:49 INFO - 'download_minidump_stackwalk': True, 12:00:49 INFO - 'download_symbols': 'ondemand', 12:00:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:00:49 INFO - 'tooltool.py': '/tools/tooltool.py', 12:00:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:00:49 INFO - '/tools/misc-python/virtualenv.py')}, 12:00:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:00:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:00:49 INFO - 'installer_path': 'installer.exe', 12:00:49 INFO - 'log_level': 'info', 12:00:49 INFO - 'log_name': 'talos', 12:00:49 INFO - 'log_to_console': True, 12:00:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:00:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:00:49 INFO - 'opt_config_files': (), 12:00:49 INFO - 'pip_index': False, 12:00:49 INFO - 'sps_profile': False, 12:00:49 INFO - 'sps_profile_interval': 0, 12:00:49 INFO - 'suite': 'dromaeojs', 12:00:49 INFO - 'system_bits': '32', 12:00:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:00:49 INFO - 'title': 'talos-linux64-ix-062', 12:00:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:00:49 INFO - 'use_talos_json': True, 12:00:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:00:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:00:49 INFO - 'work_dir': 'build'} 12:00:49 INFO - [mozharness: 2016-10-14 19:00:49.980824Z] Running clobber step. 12:00:49 INFO - Running pre-action listener: _resource_record_pre_action 12:00:49 INFO - Running main action method: clobber 12:00:49 INFO - rmtree: /builds/slave/test/build 12:00:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:00:50 INFO - Running post-action listener: _resource_record_post_action 12:00:50 INFO - [mozharness: 2016-10-14 19:00:50.965011Z] Finished clobber step (success) 12:00:50 INFO - [mozharness: 2016-10-14 19:00:50.965110Z] Running read-buildbot-config step. 12:00:50 INFO - Running pre-action listener: _resource_record_pre_action 12:00:50 INFO - Running main action method: read_buildbot_config 12:00:50 INFO - Using buildbot properties: 12:00:50 INFO - { 12:00:50 INFO - "project": "", 12:00:50 INFO - "product": "firefox", 12:00:50 INFO - "script_repo_revision": "production", 12:00:50 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:00:50 INFO - "repository": "", 12:00:50 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:00:50 INFO - "buildid": "20161014105935", 12:00:50 INFO - "pgo_build": "False", 12:00:50 INFO - "basedir": "/builds/slave/test", 12:00:50 INFO - "buildnumber": 847, 12:00:50 INFO - "slavename": "talos-linux64-ix-062", 12:00:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:00:50 INFO - "platform": "ubuntu64_hw", 12:00:50 INFO - "scheduler": "tests-autoland-linux64-talos", 12:00:50 INFO - "branch": "autoland", 12:00:50 INFO - "repo_path": "integration/autoland", 12:00:50 INFO - "revision": "09943651fa859ca1c208a0682e34dd32e7a7d8f5", 12:00:50 INFO - "stage_platform": "linux64", 12:00:50 INFO - "builduid": "83fecc11e4344fcf8a4a1c55c2dbbbe1", 12:00:50 INFO - "slavebuilddir": "test" 12:00:50 INFO - } 12:00:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:00:50 INFO - Running post-action listener: _resource_record_post_action 12:00:50 INFO - [mozharness: 2016-10-14 19:00:50.967537Z] Finished read-buildbot-config step (success) 12:00:50 INFO - [mozharness: 2016-10-14 19:00:50.967624Z] Running download-and-extract step. 12:00:50 INFO - Running pre-action listener: _resource_record_pre_action 12:00:50 INFO - Running main action method: download_and_extract 12:00:50 INFO - mkdir: /builds/slave/test/build/tests 12:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:00:50 INFO - trying https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:00:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/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 12:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/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 12:00:51 INFO - Downloaded 1361 bytes. 12:00:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:00:51 INFO - Using the following test package requirements: 12:00:51 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:00:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:00:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'jsshell-linux-x86_64.zip'], 12:00:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:00:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:00:51 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:00:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:00:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:00:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:00:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:00:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:00:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:00:52 INFO - Http code: 200 12:00:52 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 12:00:52 INFO - x-amz-cf-id: _CXjMrxD2dw7vDcdFkP-HtIhA7W_bxsahTUIOBXI8nATzXqAl1jw7A== 12:00:52 INFO - x-amz-version-id: KryJwZM.UpuMM2rbv0su3yolVl1CMCqG 12:00:52 INFO - Expected file size: 20554065 12:00:52 INFO - Obtained file size: 20554065 12:00:56 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 12:00:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:00:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:00:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:00:57 INFO - Http code: 200 12:00:57 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 12:00:57 INFO - x-amz-cf-id: OR9nxexcn7yh6B2wz69orY7bMGzT53nnB-1571iaHn3U6x4y5y7nNg== 12:00:57 INFO - x-amz-version-id: KryJwZM.UpuMM2rbv0su3yolVl1CMCqG 12:00:57 INFO - Expected file size: 20554065 12:00:57 INFO - Obtained file size: 20554065 12:01:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:01:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:01:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:01:02 INFO - Http code: 200 12:01:02 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 12:01:02 INFO - x-amz-cf-id: r4JQJHlk-Hj5wilFowc1LD9tIWKKDt83v4csttplA7999n8ULG3hMg== 12:01:02 INFO - x-amz-version-id: QbEMPXhIfhKRMtnonKqotND_VYs.y3rC 12:01:03 INFO - Expected file size: 14409006 12:01:03 INFO - Obtained file size: 14409006 12:01:03 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')]} 12:01:03 INFO - trying https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:01:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/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 12:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/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 12:01:06 INFO - Downloaded 55549078 bytes. 12:01:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:01:06 INFO - mkdir: /builds/slave/test/properties 12:01:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:01:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:01:06 INFO - Contents: 12:01:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:01:06 INFO - Running post-action listener: _resource_record_post_action 12:01:06 INFO - Running post-action listener: set_extra_try_arguments 12:01:06 INFO - [mozharness: 2016-10-14 19:01:06.835958Z] Finished download-and-extract step (success) 12:01:06 INFO - [mozharness: 2016-10-14 19:01:06.836183Z] Running populate-webroot step. 12:01:06 INFO - Running pre-action listener: _resource_record_pre_action 12:01:06 INFO - Running main action method: populate_webroot 12:01:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:01:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:01:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:01:06 INFO - '--tppagecycles', 12:01:06 INFO - '7'], 12:01:06 INFO - 'tests': ['tsvgm']}}, 12:01:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:01:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:01:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:01:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:01:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['damp', 'tps']}, 12:01:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'tests': ['damp', 'tps']}, 12:01:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['dromaeo_dom']}, 12:01:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:01:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['basic_compositor_video']}, 12:01:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:01:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['a11yr', 12:01:06 INFO - 'ts_paint', 12:01:06 INFO - 'tpaint', 12:01:06 INFO - 'sessionrestore', 12:01:06 INFO - 'sessionrestore_no_auto_restore', 12:01:06 INFO - 'tabpaint']}, 12:01:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:01:06 INFO - 'ts_paint', 12:01:06 INFO - 'tpaint', 12:01:06 INFO - 'sessionrestore', 12:01:06 INFO - 'sessionrestore_no_auto_restore', 12:01:06 INFO - 'tabpaint']}, 12:01:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:01:06 INFO - 'ts_paint', 12:01:06 INFO - 'tpaint', 12:01:06 INFO - 'sessionrestore', 12:01:06 INFO - 'sessionrestore_no_auto_restore', 12:01:06 INFO - 'tabpaint']}, 12:01:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:01:06 INFO - 'ts_paint', 12:01:06 INFO - 'tpaint', 12:01:06 INFO - 'sessionrestore', 12:01:06 INFO - 'sessionrestore_no_auto_restore', 12:01:06 INFO - 'tabpaint']}, 12:01:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['a11yr', 12:01:06 INFO - 'ts_paint', 12:01:06 INFO - 'tpaint', 12:01:06 INFO - 'sessionrestore', 12:01:06 INFO - 'sessionrestore_no_auto_restore', 12:01:06 INFO - 'tabpaint']}, 12:01:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['a11yr', 12:01:06 INFO - 'ts_paint', 12:01:06 INFO - 'tpaint', 12:01:06 INFO - 'sessionrestore', 12:01:06 INFO - 'sessionrestore_no_auto_restore', 12:01:06 INFO - 'tabpaint']}, 12:01:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['tsvgx', 12:01:06 INFO - 'tsvgr_opacity', 12:01:06 INFO - 'tart', 12:01:06 INFO - 'tscrollx', 12:01:06 INFO - 'cart']}, 12:01:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:01:06 INFO - 'tsvgr_opacity', 12:01:06 INFO - 'tart', 12:01:06 INFO - 'tscrollx', 12:01:06 INFO - 'cart']}, 12:01:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'talos_options': ['--disable-e10s'], 12:01:06 INFO - 'tests': ['tp5o']}, 12:01:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'tests': ['tp5o']}, 12:01:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'talos_options': ['--disable-e10s', 12:01:06 INFO - '--xperf_path', 12:01:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:06 INFO - 'tests': ['tp5n']}, 12:01:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:06 INFO - 'talos_options': ['--xperf_path', 12:01:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:06 INFO - 'tests': ['tp5n']}}, 12:01:06 INFO - 'talos.zip': {'path': '', 12:01:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:01:06 INFO - Running post-action listener: _resource_record_post_action 12:01:06 INFO - [mozharness: 2016-10-14 19:01:06.859316Z] Finished populate-webroot step (success) 12:01:06 INFO - [mozharness: 2016-10-14 19:01:06.859405Z] Running create-virtualenv step. 12:01:06 INFO - Running pre-action listener: _resource_record_pre_action 12:01:06 INFO - Running main action method: create_virtualenv 12:01:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:01:06 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 12:01:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:01:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:01:06 INFO - Using real prefix '/usr' 12:01:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:01:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:01:09 INFO - Installing pip.................done. 12:01:09 INFO - Return code: 0 12:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:01:09 INFO - Reading from file tmpfile_stdout 12:01:09 INFO - Output received: 12:01:09 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) 12:01:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:01:09 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')]} 12:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:09 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')]} 12:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:09 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:09 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 12:01:09 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 12:01:09 INFO - Using env: {'DISPLAY': ':0', 12:01:09 INFO - 'HOME': '/home/cltbld', 12:01:09 INFO - 'LANG': 'en_US.UTF-8', 12:01:09 INFO - 'LANGUAGE': 'en_US:en', 12:01:09 INFO - 'LOGNAME': 'cltbld', 12:01:09 INFO - 'MAIL': '/var/mail/cltbld', 12:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:09 INFO - 'MOZ_NO_REMOTE': '1', 12:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:09 INFO - 'NO_EM_RESTART': '1', 12:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:09 INFO - 'PWD': '/builds/slave/test', 12:01:09 INFO - 'SHELL': '/bin/bash', 12:01:09 INFO - 'SHLVL': '1', 12:01:09 INFO - 'TERM': 'linux', 12:01:09 INFO - 'TMOUT': '86400', 12:01:09 INFO - 'USER': 'cltbld', 12:01:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:09 INFO - '_': '/tools/buildbot/bin/python'} 12:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:09 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 12:01:09 INFO - Cleaning up... 12:01:09 INFO - Return code: 0 12:01:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:01:09 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')]} 12:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:09 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')]} 12:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:09 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:09 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 12:01:09 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 12:01:09 INFO - Using env: {'DISPLAY': ':0', 12:01:09 INFO - 'HOME': '/home/cltbld', 12:01:09 INFO - 'LANG': 'en_US.UTF-8', 12:01:09 INFO - 'LANGUAGE': 'en_US:en', 12:01:09 INFO - 'LOGNAME': 'cltbld', 12:01:09 INFO - 'MAIL': '/var/mail/cltbld', 12:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:09 INFO - 'MOZ_NO_REMOTE': '1', 12:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:09 INFO - 'NO_EM_RESTART': '1', 12:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:09 INFO - 'PWD': '/builds/slave/test', 12:01:09 INFO - 'SHELL': '/bin/bash', 12:01:09 INFO - 'SHLVL': '1', 12:01:09 INFO - 'TERM': 'linux', 12:01:09 INFO - 'TMOUT': '86400', 12:01:09 INFO - 'USER': 'cltbld', 12:01:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:09 INFO - '_': '/tools/buildbot/bin/python'} 12:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:10 INFO - Downloading/unpacking psutil>=3.1.1 12:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:12 INFO - Installing collected packages: psutil 12:01:12 INFO - Running setup.py install for psutil 12:01:12 INFO - building 'psutil._psutil_linux' extension 12:01:12 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 12:01:12 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 12:01:12 INFO - building 'psutil._psutil_posix' extension 12:01:12 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 12:01:12 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 12:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:12 INFO - Successfully installed psutil 12:01:12 INFO - Cleaning up... 12:01:12 INFO - Return code: 0 12:01:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:01:12 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')]} 12:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:12 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')]} 12:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:12 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:12 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 12:01:12 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 12:01:12 INFO - Using env: {'DISPLAY': ':0', 12:01:12 INFO - 'HOME': '/home/cltbld', 12:01:12 INFO - 'LANG': 'en_US.UTF-8', 12:01:12 INFO - 'LANGUAGE': 'en_US:en', 12:01:12 INFO - 'LOGNAME': 'cltbld', 12:01:12 INFO - 'MAIL': '/var/mail/cltbld', 12:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:12 INFO - 'MOZ_NO_REMOTE': '1', 12:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:12 INFO - 'NO_EM_RESTART': '1', 12:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:12 INFO - 'PWD': '/builds/slave/test', 12:01:12 INFO - 'SHELL': '/bin/bash', 12:01:12 INFO - 'SHLVL': '1', 12:01:12 INFO - 'TERM': 'linux', 12:01:12 INFO - 'TMOUT': '86400', 12:01:12 INFO - 'USER': 'cltbld', 12:01:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:12 INFO - '_': '/tools/buildbot/bin/python'} 12:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:01:14 INFO - Installing collected packages: mozsystemmonitor 12:01:14 INFO - Running setup.py install for mozsystemmonitor 12:01:14 INFO - Successfully installed mozsystemmonitor 12:01:14 INFO - Cleaning up... 12:01:15 INFO - Return code: 0 12:01:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:01:15 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')]} 12:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:15 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')]} 12:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:15 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:15 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 12:01:15 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 12:01:15 INFO - Using env: {'DISPLAY': ':0', 12:01:15 INFO - 'HOME': '/home/cltbld', 12:01:15 INFO - 'LANG': 'en_US.UTF-8', 12:01:15 INFO - 'LANGUAGE': 'en_US:en', 12:01:15 INFO - 'LOGNAME': 'cltbld', 12:01:15 INFO - 'MAIL': '/var/mail/cltbld', 12:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:15 INFO - 'MOZ_NO_REMOTE': '1', 12:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:15 INFO - 'NO_EM_RESTART': '1', 12:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:15 INFO - 'PWD': '/builds/slave/test', 12:01:15 INFO - 'SHELL': '/bin/bash', 12:01:15 INFO - 'SHLVL': '1', 12:01:15 INFO - 'TERM': 'linux', 12:01:15 INFO - 'TMOUT': '86400', 12:01:15 INFO - 'USER': 'cltbld', 12:01:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:15 INFO - '_': '/tools/buildbot/bin/python'} 12:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:01:15 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 12:01:15 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 12:01:15 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 12:01:15 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 12:01:15 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 12:01:15 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 12:01:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:01:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:01:17 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 12:01:17 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 12:01:17 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 12:01:17 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 12:01:17 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 12:01:17 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 12:01:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:01:17 INFO - warning: no files found matching '*.txt' 12:01:17 INFO - no previously-included directories found matching 'build' 12:01:17 INFO - no previously-included directories found matching 'dist' 12:01:17 INFO - no previously-included directories found matching '.git*' 12:01:17 INFO - Installing collected packages: jsonschema, functools32 12:01:17 INFO - Running setup.py install for functools32 12:01:17 INFO - warning: no files found matching '*.txt' 12:01:17 INFO - no previously-included directories found matching 'build' 12:01:17 INFO - no previously-included directories found matching 'dist' 12:01:17 INFO - no previously-included directories found matching '.git*' 12:01:17 INFO - Successfully installed jsonschema functools32 12:01:17 INFO - Cleaning up... 12:01:17 INFO - Return code: 0 12:01:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:17 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:17 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 12:01:17 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 12:01:17 INFO - Using env: {'DISPLAY': ':0', 12:01:17 INFO - 'HOME': '/home/cltbld', 12:01:17 INFO - 'LANG': 'en_US.UTF-8', 12:01:17 INFO - 'LANGUAGE': 'en_US:en', 12:01:17 INFO - 'LOGNAME': 'cltbld', 12:01:17 INFO - 'MAIL': '/var/mail/cltbld', 12:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:17 INFO - 'MOZ_NO_REMOTE': '1', 12:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:17 INFO - 'NO_EM_RESTART': '1', 12:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:17 INFO - 'PWD': '/builds/slave/test', 12:01:17 INFO - 'SHELL': '/bin/bash', 12:01:17 INFO - 'SHLVL': '1', 12:01:17 INFO - 'TERM': 'linux', 12:01:17 INFO - 'TMOUT': '86400', 12:01:17 INFO - 'USER': 'cltbld', 12:01:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:17 INFO - '_': '/tools/buildbot/bin/python'} 12:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:01:17 INFO - Cleaning up... 12:01:17 INFO - Return code: 0 12:01:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:17 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:17 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 12:01:17 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 12:01:17 INFO - Using env: {'DISPLAY': ':0', 12:01:17 INFO - 'HOME': '/home/cltbld', 12:01:17 INFO - 'LANG': 'en_US.UTF-8', 12:01:17 INFO - 'LANGUAGE': 'en_US:en', 12:01:17 INFO - 'LOGNAME': 'cltbld', 12:01:17 INFO - 'MAIL': '/var/mail/cltbld', 12:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:17 INFO - 'MOZ_NO_REMOTE': '1', 12:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:17 INFO - 'NO_EM_RESTART': '1', 12:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:17 INFO - 'PWD': '/builds/slave/test', 12:01:17 INFO - 'SHELL': '/bin/bash', 12:01:17 INFO - 'SHLVL': '1', 12:01:17 INFO - 'TERM': 'linux', 12:01:17 INFO - 'TMOUT': '86400', 12:01:17 INFO - 'USER': 'cltbld', 12:01:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:17 INFO - '_': '/tools/buildbot/bin/python'} 12:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:01:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:01:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 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 12:01:20 INFO - Downloading docopt-0.6.1.tar.gz 12:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:01:20 INFO - Installing collected packages: blobuploader, requests, docopt 12:01:20 INFO - Running setup.py install for blobuploader 12:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:01:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:01:20 INFO - Running setup.py install for requests 12:01:21 INFO - Running setup.py install for docopt 12:01:21 INFO - Successfully installed blobuploader requests docopt 12:01:21 INFO - Cleaning up... 12:01:21 INFO - Return code: 0 12:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:21 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:21 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 12:01:21 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 12:01:21 INFO - Using env: {'DISPLAY': ':0', 12:01:21 INFO - 'HOME': '/home/cltbld', 12:01:21 INFO - 'LANG': 'en_US.UTF-8', 12:01:21 INFO - 'LANGUAGE': 'en_US:en', 12:01:21 INFO - 'LOGNAME': 'cltbld', 12:01:21 INFO - 'MAIL': '/var/mail/cltbld', 12:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:21 INFO - 'MOZ_NO_REMOTE': '1', 12:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:21 INFO - 'NO_EM_RESTART': '1', 12:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:21 INFO - 'PWD': '/builds/slave/test', 12:01:21 INFO - 'SHELL': '/bin/bash', 12:01:21 INFO - 'SHLVL': '1', 12:01:21 INFO - 'TERM': 'linux', 12:01:21 INFO - 'TMOUT': '86400', 12:01:21 INFO - 'USER': 'cltbld', 12:01:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:21 INFO - '_': '/tools/buildbot/bin/python'} 12:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:21 INFO - Running setup.py (path:/tmp/pip-waZa3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:21 INFO - Running setup.py (path:/tmp/pip-pCZA31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:21 INFO - Running setup.py (path:/tmp/pip-t3P4pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:21 INFO - Running setup.py (path:/tmp/pip-CDjnKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:21 INFO - Running setup.py (path:/tmp/pip-ZJ9cum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:22 INFO - Running setup.py (path:/tmp/pip-Y2jZDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:22 INFO - Running setup.py (path:/tmp/pip-syDsg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:22 INFO - Running setup.py (path:/tmp/pip-q4fGBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:22 INFO - Running setup.py (path:/tmp/pip-tN9H5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:22 INFO - Running setup.py (path:/tmp/pip-2_YjMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:22 INFO - Running setup.py (path:/tmp/pip-r_cukV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:22 INFO - Running setup.py (path:/tmp/pip-lzDDUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:22 INFO - Running setup.py (path:/tmp/pip-R9UjBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:22 INFO - Running setup.py (path:/tmp/pip-5msS8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:22 INFO - Running setup.py (path:/tmp/pip-qHmNT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:22 INFO - Running setup.py (path:/tmp/pip-D_U6Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:22 INFO - Running setup.py (path:/tmp/pip-Q4Qn5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:01:22 INFO - Running setup.py install for manifestparser 12:01:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Running setup.py install for mozcrash 12:01:23 INFO - Running setup.py install for mozdebug 12:01:23 INFO - Running setup.py install for mozdevice 12:01:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Running setup.py install for mozfile 12:01:23 INFO - Running setup.py install for mozhttpd 12:01:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Running setup.py install for mozinfo 12:01:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Running setup.py install for mozInstall 12:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Running setup.py install for mozleak 12:01:23 INFO - Running setup.py install for mozlog 12:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:01:23 INFO - Running setup.py install for moznetwork 12:01:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:01:24 INFO - Running setup.py install for mozprocess 12:01:24 INFO - Running setup.py install for mozprofile 12:01:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:01:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:01:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:01:24 INFO - Running setup.py install for mozrunner 12:01:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:01:24 INFO - Running setup.py install for mozscreenshot 12:01:24 INFO - Running setup.py install for moztest 12:01:24 INFO - Running setup.py install for mozversion 12:01:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:01:24 INFO - Cleaning up... 12:01:24 INFO - Return code: 0 12:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:24 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:24 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 12:01:24 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 12:01:24 INFO - Using env: {'DISPLAY': ':0', 12:01:24 INFO - 'HOME': '/home/cltbld', 12:01:24 INFO - 'LANG': 'en_US.UTF-8', 12:01:24 INFO - 'LANGUAGE': 'en_US:en', 12:01:24 INFO - 'LOGNAME': 'cltbld', 12:01:24 INFO - 'MAIL': '/var/mail/cltbld', 12:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:24 INFO - 'MOZ_NO_REMOTE': '1', 12:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:24 INFO - 'NO_EM_RESTART': '1', 12:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:24 INFO - 'PWD': '/builds/slave/test', 12:01:24 INFO - 'SHELL': '/bin/bash', 12:01:24 INFO - 'SHLVL': '1', 12:01:24 INFO - 'TERM': 'linux', 12:01:24 INFO - 'TMOUT': '86400', 12:01:24 INFO - 'USER': 'cltbld', 12:01:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:24 INFO - '_': '/tools/buildbot/bin/python'} 12:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:24 INFO - Running setup.py (path:/tmp/pip-JE9zIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:25 INFO - Running setup.py (path:/tmp/pip-RIHVOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:25 INFO - Running setup.py (path:/tmp/pip-OQeppq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:25 INFO - Running setup.py (path:/tmp/pip-gsmhcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:25 INFO - Running setup.py (path:/tmp/pip-ujtC8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:25 INFO - Running setup.py (path:/tmp/pip-DyY1l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:25 INFO - Running setup.py (path:/tmp/pip-KPuczy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:25 INFO - Running setup.py (path:/tmp/pip-GjvB5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:25 INFO - Running setup.py (path:/tmp/pip-c6RjLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:25 INFO - Running setup.py (path:/tmp/pip-ezAFHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:25 INFO - Running setup.py (path:/tmp/pip-dkE3L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:25 INFO - Running setup.py (path:/tmp/pip-Ob1uTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:25 INFO - Running setup.py (path:/tmp/pip-g0UoWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:25 INFO - Running setup.py (path:/tmp/pip-beS2lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:25 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)) 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:25 INFO - Running setup.py (path:/tmp/pip-HTx11w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:26 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)) 12:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:26 INFO - Running setup.py (path:/tmp/pip-9gATHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:26 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)) 12:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:26 INFO - Running setup.py (path:/tmp/pip-wYNltd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:26 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)) 12:01:26 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)) 12:01:26 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)) 12:01:26 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)) 12:01:26 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)) 12:01:26 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)) 12:01:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:01:26 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 12:01:26 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 12:01:26 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 12:01:26 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 12:01:26 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 12:01:26 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 12:01:28 INFO - Downloading blessings-1.6.tar.gz 12:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:01:28 INFO - Installing collected packages: blessings 12:01:28 INFO - Running setup.py install for blessings 12:01:28 INFO - Successfully installed blessings 12:01:28 INFO - Cleaning up... 12:01:28 INFO - Return code: 0 12:01:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:28 INFO - Reading from file tmpfile_stdout 12:01:28 INFO - Current package versions: 12:01:28 INFO - argparse == 1.2.1 12:01:28 INFO - blessings == 1.6 12:01:28 INFO - blobuploader == 1.2.4 12:01:28 INFO - docopt == 0.6.1 12:01:28 INFO - functools32 == 3.2.3-2 12:01:28 INFO - jsonschema == 2.5.1 12:01:28 INFO - manifestparser == 1.1 12:01:28 INFO - mozInstall == 1.12 12:01:28 INFO - mozcrash == 0.17 12:01:28 INFO - mozdebug == 0.1 12:01:28 INFO - mozdevice == 0.48 12:01:28 INFO - mozfile == 1.2 12:01:28 INFO - mozhttpd == 0.7 12:01:28 INFO - mozinfo == 0.9 12:01:28 INFO - mozleak == 0.1 12:01:28 INFO - mozlog == 3.4 12:01:28 INFO - moznetwork == 0.27 12:01:28 INFO - mozprocess == 0.23 12:01:28 INFO - mozprofile == 0.28 12:01:28 INFO - mozrunner == 6.12 12:01:28 INFO - mozscreenshot == 0.1 12:01:28 INFO - mozsystemmonitor == 0.3 12:01:28 INFO - moztest == 0.7 12:01:28 INFO - mozversion == 1.4 12:01:28 INFO - psutil == 3.1.1 12:01:28 INFO - requests == 1.2.3 12:01:28 INFO - wsgiref == 0.1.2 12:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:28 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')]} 12:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:28 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')]} 12:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:28 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:28 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 12:01:28 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 12:01:28 INFO - Using env: {'DISPLAY': ':0', 12:01:28 INFO - 'HOME': '/home/cltbld', 12:01:28 INFO - 'LANG': 'en_US.UTF-8', 12:01:28 INFO - 'LANGUAGE': 'en_US:en', 12:01:28 INFO - 'LOGNAME': 'cltbld', 12:01:28 INFO - 'MAIL': '/var/mail/cltbld', 12:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:28 INFO - 'MOZ_NO_REMOTE': '1', 12:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:28 INFO - 'NO_EM_RESTART': '1', 12:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:28 INFO - 'PWD': '/builds/slave/test', 12:01:28 INFO - 'SHELL': '/bin/bash', 12:01:28 INFO - 'SHLVL': '1', 12:01:28 INFO - 'TERM': 'linux', 12:01:28 INFO - 'TMOUT': '86400', 12:01:28 INFO - 'USER': 'cltbld', 12:01:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:28 INFO - '_': '/tools/buildbot/bin/python'} 12:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 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)) 12:01:28 INFO - Cleaning up... 12:01:28 INFO - Return code: 0 12:01:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:01:28 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')]} 12:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:28 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')]} 12:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:28 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 0x7f1bb4fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', '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 12:01:28 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 12:01:28 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 12:01:28 INFO - Using env: {'DISPLAY': ':0', 12:01:28 INFO - 'HOME': '/home/cltbld', 12:01:28 INFO - 'LANG': 'en_US.UTF-8', 12:01:28 INFO - 'LANGUAGE': 'en_US:en', 12:01:28 INFO - 'LOGNAME': 'cltbld', 12:01:28 INFO - 'MAIL': '/var/mail/cltbld', 12:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:28 INFO - 'MOZ_NO_REMOTE': '1', 12:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:28 INFO - 'NO_EM_RESTART': '1', 12:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:28 INFO - 'PWD': '/builds/slave/test', 12:01:28 INFO - 'SHELL': '/bin/bash', 12:01:28 INFO - 'SHLVL': '1', 12:01:28 INFO - 'TERM': 'linux', 12:01:28 INFO - 'TMOUT': '86400', 12:01:28 INFO - 'USER': 'cltbld', 12:01:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:28 INFO - '_': '/tools/buildbot/bin/python'} 12:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:01:29 INFO - Cleaning up... 12:01:29 INFO - Return code: 0 12:01:29 INFO - Running post-action listener: _resource_record_post_action 12:01:29 INFO - Running post-action listener: _start_resource_monitoring 12:01:29 INFO - Starting resource monitoring. 12:01:29 INFO - [mozharness: 2016-10-14 19:01:29.087203Z] Finished create-virtualenv step (success) 12:01:29 INFO - [mozharness: 2016-10-14 19:01:29.087784Z] Running install step. 12:01:29 INFO - Running pre-action listener: _resource_record_pre_action 12:01:29 INFO - Running main action method: install 12:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:29 INFO - Reading from file tmpfile_stdout 12:01:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:01:29 INFO - Reading from file tmpfile_stdout 12:01:29 INFO - Output received: 12:01:29 INFO - Usage: mozinstall [options] installer 12:01:29 INFO - Options: 12:01:29 INFO - -h, --help show this help message and exit 12:01:29 INFO - -d DEST, --destination=DEST 12:01:29 INFO - Directory to install application into. [default: 12:01:29 INFO - "/builds/slave/test"] 12:01:29 INFO - --app=APP Application being installed. [default: firefox] 12:01:29 INFO - mkdir: /builds/slave/test/build/application 12:01:29 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'] 12:01:29 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 12:01:45 INFO - Reading from file tmpfile_stdout 12:01:45 INFO - Output received: 12:01:45 INFO - /builds/slave/test/build/application/firefox/firefox 12:01:45 INFO - Running post-action listener: _resource_record_post_action 12:01:45 INFO - [mozharness: 2016-10-14 19:01:45.457417Z] Finished install step (success) 12:01:45 INFO - [mozharness: 2016-10-14 19:01:45.457660Z] Running run-tests step. 12:01:45 INFO - Running pre-action listener: _resource_record_pre_action 12:01:45 INFO - Running main action method: run_tests 12:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:01:45 INFO - Python 2.7.3 12:01:45 INFO - Return code: 0 12:01:45 INFO - grabbing minidump binary from tooltool 12:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:01:45 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 0x21c9f60>, '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 0x21cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:01:45 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 12:01:45 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 12:01:45 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 12:01:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:45 INFO - Return code: 0 12:01:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:01:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:01:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:01:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:01:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:01:45 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/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:01:45 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/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 12:01:45 INFO - Using env: {'DISPLAY': ':0', 12:01:45 INFO - 'HOME': '/home/cltbld', 12:01:45 INFO - 'LANG': 'en_US.UTF-8', 12:01:45 INFO - 'LANGUAGE': 'en_US:en', 12:01:45 INFO - 'LOGNAME': 'cltbld', 12:01:45 INFO - 'MAIL': '/var/mail/cltbld', 12:01:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:45 INFO - 'MOZ_NO_REMOTE': '1', 12:01:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:45 INFO - 'NO_EM_RESTART': '1', 12:01:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:45 INFO - 'PWD': '/builds/slave/test', 12:01:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:45 INFO - 'SHELL': '/bin/bash', 12:01:45 INFO - 'SHLVL': '1', 12:01:45 INFO - 'TERM': 'linux', 12:01:45 INFO - 'TMOUT': '86400', 12:01:45 INFO - 'USER': 'cltbld', 12:01:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829', 12:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:45 INFO - '_': '/tools/buildbot/bin/python'} 12:01:45 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/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:01:45 INFO - mozversion application_buildid: 20161014105935 12:01:45 INFO - mozversion application_changeset: 09943651fa859ca1c208a0682e34dd32e7a7d8f5 12:01:45 INFO - mozversion application_display_name: Nightly 12:01:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:45 INFO - mozversion application_name: Firefox 12:01:45 INFO - mozversion application_remotingname: firefox 12:01:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:01:45 INFO - mozversion application_vendor: Mozilla 12:01:45 INFO - mozversion application_version: 52.0a1 12:01:45 INFO - mozversion platform_buildid: 20161014105935 12:01:45 INFO - mozversion platform_changeset: 09943651fa859ca1c208a0682e34dd32e7a7d8f5 12:01:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:01:45 INFO - mozversion platform_version: 52.0a1 12:01:45 INFO - using testdate: 1476471705 12:01:45 INFO - actual date: 1476471705 12:01:45 INFO - starting webserver on 'localhost:49455' 12:01:45 INFO - SUITE-START | Running 2 tests 12:01:45 INFO - TEST-START | dromaeo_css 12:01:45 INFO - operating with platform_type : linux_ 12:01:45 INFO - Initialising browser for dromaeo_css test... 12:01:45 INFO - TEST-INFO | started process 22563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8lDVz/profile http://localhost:49455/getInfo.html) 12:01:49 INFO - PROCESS | 22563 | __metrics Screen width/height:1600/1200 12:01:49 INFO - PROCESS | 22563 | colorDepth:24 12:01:49 INFO - PROCESS | 22563 | Browser inner width/height: 1024/697 12:01:49 INFO - PROCESS | 22563 | __metrics 12:01:50 INFO - PROCESS | 22563 | 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" 12:01:50 INFO - PROCESS | 22563 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:01:51 INFO - PROCESS | 22563 | console.error: PushService: 12:01:51 INFO - PROCESS | 22563 | stateChangeProcessEnqueue: Error transitioning state 12:01:51 INFO - PROCESS | 22563 | UnknownError 12:01:51 INFO - TEST-INFO | 22563: exit 0 12:01:51 INFO - Browser initialized. 12:01:51 INFO - Running cycle 1/1 for dromaeo_css test... 12:01:51 INFO - TEST-INFO | started process 22644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8lDVz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:04 INFO - PROCESS | 22644 | RSS: Main: 173506560 12:02:04 INFO - PROCESS | 22644 | 12:02:54 INFO - PROCESS | 22644 | 1476471774951 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] 12:05:09 INFO - PROCESS | 22644 | Cycle 1(1): loaded http://localhost:49455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49455/tests/dromaeo/cssquery-ext.html) 12:05:11 INFO - PROCESS | 22644 | RSS: Main: 276303872 12:05:11 INFO - PROCESS | 22644 | 12:08:13 INFO - PROCESS | 22644 | Cycle 1(1): loaded http://localhost:49455/tests/dromaeo/cssquery-ext.html (next: http://localhost:49455/tests/dromaeo/cssquery-jquery.html) 12:08:14 INFO - PROCESS | 22644 | RSS: Main: 273014784 12:08:14 INFO - PROCESS | 22644 | 12:11:16 INFO - PROCESS | 22644 | Cycle 1(1): loaded http://localhost:49455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49455/tests/dromaeo/cssquery-mootools.html) 12:11:17 INFO - PROCESS | 22644 | RSS: Main: 238321664 12:11:17 INFO - PROCESS | 22644 | 12:14:19 INFO - PROCESS | 22644 | Cycle 1(1): loaded http://localhost:49455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49455/tests/dromaeo/cssquery-prototype.html) 12:14:20 INFO - PROCESS | 22644 | RSS: Main: 244043776 12:14:20 INFO - PROCESS | 22644 | 12:17:23 INFO - PROCESS | 22644 | Cycle 1(1): loaded http://localhost:49455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49455/tests/dromaeo/cssquery-yui.html) 12:17:24 INFO - PROCESS | 22644 | RSS: Main: 219496448 12:17:24 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | Cycle 1(1): loaded http://localhost:49455/tests/dromaeo/cssquery-yui.html (next: http://localhost:49455/tests/dromaeo/cssquery-dojo.html) 12:20:27 INFO - PROCESS | 22644 | RSS: Main: 302419968 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | __start_tp_report 12:20:27 INFO - PROCESS | 22644 | _x_x_mozilla_page_load 12:20:27 INFO - PROCESS | 22644 | _x_x_mozilla_page_load_details 12:20:27 INFO - PROCESS | 22644 | |i|pagename|runs| 12:20:27 INFO - PROCESS | 22644 | |0;dojo.html;2594.935126621834;2612.9869350653244;2641.234042127783;2650.2579277802224;2659.0693257359926;4601.861944141673;4691.859244222679;4773.474917759048;4788.616910647149;4813;4724.3622111015;4729.503402142777;4773.5226477352335;4823.372961514998;4890.168671325874;4334.718243314191;4419.182451246514;4428.092241090585;4437.046035102452;4448.888777780565;4407.537208593099;4416.5583441655735;4422.425084738979;4441.2893936970095;4443.866683999485;4422.690411671184;4447.866564003085;4481.417415735949;4482.596566309048;4515.074409745994;4288.656907447396;4333.306670932636;4345.1961387143165;4384.9561504384865;4386.254336762758;4322.416473776031;4356.019895523514;4365.3670217818235;4365.738055716635;4367.890802729926;4749.762511874427;4751.3348131261655;4767.69010014348;4788.018456216468;4835.685680430761;5174.663646862942;5183.403908550489;5195.3246078009615;5198.298229738974;5262;5051.570616497565;5119.8208062717995;5205.713685747282;5212.374515058179;5221.791128354861;4777.3072904429355;4795.328653988445;4813.807447702053;4840.152973229741;4877.195262781602;5258;5268.789248430096;5291.788328466895;5296.232046353257;5351.6788992659785;4949.975250123798;5100.744962751847;5121.9743901281;5128.640995130305;5134.383873935151;5039.344885164978;5048.343715316985;5048.419431765321;5061.240813877874;5140.845774626767;4992.825251116194;5045.84862454127;5045.949540504548;5098.821541246039;5108.489151084936;5023.824166154167;5029.195328747456;5029.622778291569;5032.647714660012;5097.898042039213;4298.118885628439;4331.068820203672;4340.283853164193;4349.28236840924;4376.321670141133;3842.51968503937;3851.807409629507;3881.1849511602313;3919.7844118573753;3939.9015024624614;4363.890902727458;4379.605835474823;4386;4386.780660966939;4437.5784300491405;4959.305697202394;5051.217061355495;5180.041692286939;5197.532222100029;5199.142141546678;4323.113761678848;4344.9565504344555;4378.08060307339;4379.693421460467;4450.799714012877;4665.533446655308;4671.392718946583;4672.556107169813;4673.6728429009645;4735.076660051326;4698;4831.879203019882;4838.854834354975;4840.34655321527;4899.608031357411;5090.338256026693;5117.948820511896;5118.283440318432;5152.407473140637;5171.224316352577;4779.808807647655;4785.545373189541;4791.640626953063;4829.830955916526;4846.297286893451;5050.04049230645;5054.924176137288;5055.191169412877;5055.772490237875;5062.190049592047;5006.299118123393;5104.9744751276;5115.18157094863;5144.331236939174;5158.871028224325;4976.278439626306;4977.527134922177;4980.27785971025;4993.500649934977;5040.697558146523;5011.724355160502;5017.498250174954;5018.623603229846;5026.547610715053;5074.086664400444;4840.685355451885;4885.8045678172475;4924.433690125681;4948.777305021211;4999.425066117443;5077.949220507748;5078.542931136216;5087.898242035065;5117.769700363567;5121.103806833864;4830.082284365959;4936.827211047596;4974.875628109182;4976.800927962841;5037.093323201712 12:20:27 INFO - PROCESS | 22644 | |1;ext.html;558.6731761919277;580.3152280309233;582.5776312173674;582.7465052702072;593.5637306579666;27545.58681619775;37206.44190337147;38511.807440962824;38637.42043869344;43435.34846977298;39334.60665393345;39707.205855882865;39741.40387894184;39812.80093599528;39855.60144398555;7434.925650743491;7586.089669239672;7588;7598.012258406399;7600.923990760105;7505.737299194529;7588.58262795546;7591.316781489665;7597.696092156307;7600.353969912564;7541.170471248159;7568.545887246755;7597.468177227596;7602.619869006555;7608.125065617442;7487.737929172453;7488.438367122488;7540.962295188544;7550.28272314132;7588.848223035564;7594.202608726115;7650.770476885702;7655.617219139021;7659.540427574363;7659.61701914902;35783.10542236439;36083.27833443316;36086.63913360859;36111.81944090289;36116.277674446625;3027.5307327364294;3209.2297848516187;3621.8732344368086;3660.432632941872;3672.8981305608477;27515.58726619102;27908.209179082132;28315.433691326263;30163.92134965905;30987.690123098706;3551.708700193996;3552.715782737401;3558.395072837624;3575.4458059000895;3621.9112147432897;238289;239426.45161935335;239667;240377;241307;53976;54552.45447545553;54588;54605.45394546083;54638.18042729362;32534;33586;33600.49599256013;57607;57882;14455.349509272108;14473.348699308557;14669;14670.119792812466;14676.339564719614;10539.209559283085;10783.299085559414;10787;10789.082927951054;10791.676249712522;17749.822501774815;17969.472594829323;17974.550636233937;17980.19089140992;18039.458816235532;6858.759943401957;6867.175938887365;6945.992831039471;7030.226675065739;7105.644717764091;615.8306465721962;689.7965100295424;698.7798843364324;749.2582343480025;760.9391248700201;25923.870380647975;26167.666160698656;26260.73739262583;27620.58569121465;27629.032983845467;892.6607889002267;895.9820803583892;917.2386918857333;917.7522069041321;931.5901003558413;14207.85792142086;14281.500147494788;14492.927535362256;14498.420063197354;14791;110733.44633276782;111731.44134279276;112354;112429;112430.43784781024;47587.762061189474;48290.27564586534;48290.75854620775;48341;48376;1042.9009244121796;1106.7067227184803;1147.0823341326904;1154.7863645225493;1194.9522019119486;26939.595906061033;28009.719902800713;28493.572596410657;28884.15419680887;29375.55936660909;40782;40959.59040409558;41129;41205.381919270636;41237.79381103075;248278;248918;249533;250193;250350;21673.783262167806;22166;22241.44396390103;24948.625770613093;25759;39062.414063789634;39505;39537.406938895365;39682.60317396789;39907;33971.320573587895;34396;34742.82628586841;34811.129721757155;34815.477767833;33363;33409.83295083509;34014.48978265378;34501.827490862386;34883.30233395369;34419.31161376708;34573.827130864185;34816.651833481345;34915.65084349124;35131;27440.588391173747;27521.17436476909;31979.520307195875;32082.11904666879;32533.349333012735;24395.51208975775;24459;24853.751462485143;24939.35514721672;25009.749902500742 12:20:27 INFO - PROCESS | 22644 | |2;jquery.html;354.148273402467;356.9875054373097;358.97307701922364;373.14735828631547;380.7144641518861;15284.465043723472;16317.265723042461;16718.164091795406;16828.242729077192;16833.242504087313;15991.360345586192;16575.585610359747;17027.40404085857;17154.142292885335;17214;4707.2939059141145;4926.11329960607;4968.70187788732;4978.900421991558;4981.252812078199;3615.493830863681;3816.0459885028745;4876.487968763282;5466.316710411179;5831.067029275317;5801.332846722638;5926.644401335933;5935.614185077978;5995.460408563228;6003.279606447232;5717.342505611846;5861.150133230679;5890.823275301748;5897.587168898201;5903.232579764646;4965.677230980011;5170.6122040847085;5176.974115129438;5179.482051794828;5179.507946745053;21127;21631.783682163135;21759.23842665515;21878.562428751335;21917.452063698376;1873.7002079667188;1906.4852489827808;1918.6642337590865;1947.6007418479178;2373.4303767095944;12660.746785064339;12733.745325093447;13134.802977955338;13801.654958626013;13821.308934553232;1673.1801417305555;1680.747263207991;1697.3634886917405;1709.3931654262683;1766.1610734900949;65820.6708966457;69004;69332.99999999949;69761.65119174423;71032;9422.90577094234;9446.433214007182;9766.169875560516;9839.262055345878;10001.399916005063;13301.800472992913;13309.66725831862;13318.134321269086;13329.466821327038;13336.39986200604;7140.143182817991;7321.267873212742;7401.444891633149;7445.85108297831;7537.9623101884135;7005.859882802315;7045.401140902978;7100.60946647929;7241.203467618558;7257.439650475173;6007.429294217042;6079.240094988127;6154.3845615438095;6194.473469755121;6279.591826531261;1559.423013485018;1687.12269619797;1696.3892998520769;1697.2616911643229;1711.8117007129206;762.5310434082999;835.6323217784155;838.1827717975048;867.6355930509201;868.8132051608934;17666.823331766776;18806.717899231524;19057.523561911064;19079;19273.614527709367;883.3728053082383;890.3055616619048;894.4588523942921;895.9641614335484;920.1350730313484;9987.151092157103;10518.947405262925;10541.578336866593;10635.840462393071;10677.519511621995;349450;354357;354730;355239;358369;44987.10025799466;62688.37311626917;76448.23551764523;78215;78701.60649196718;942.7743932887082;993.5975929748463;1003.2024540490182;1004.9045340692622;1012.8075665623508;15705.450309239122;16370.590735231239;16621.50135495937;16756.58108547296;16833.747493787847;35761.64238357583;35869.28261434809;36666.63333366632;36828.237882158406;37516.2496750058;45453.54546454493;48125;50384;51360.74319628378;52067;7707.421943354158;7806.258405451473;7825.843483130419;7839.84320313602;7938.285554300141;12480.188787728768;12580.937095314832;12736.6815829605;12811.615651530468;13108.657063728424;10441.425721585385;10752.13001182919;10769.62306319275;11009.83485247738;11018.559257629606;10643.733906652396;10687.198460115367;10736.677899663022;11182.776344472903;11251.549938002716;10991.340519568852;11134.443277836237;11141.888581114084;11165.832512512481;11819.704507387383;7615.619219039137;7772.961135194288;7887.132415434183;7992.724801630896;8042.758717238492;9858.55636496345;10368.844467333147;11037;11227.66317010491;11526.250793698382 12:20:27 INFO - PROCESS | 22644 | |3;mootools.html;1355.85763494833;1396.6368744126528;1473.5800296915381;1661.1777170300702;1715.8627309815215;6487.44856687181;6696.2634110247955;7134.785956421303;7699.730509432171;7727.150013498518;7102.822429439267;7369.926300736991;7396.852062958737;7612.08654961404;7625.237476252386;2143.8499305048654;2165.069020321261;2167.8916054197307;2171.381156370435;2173.282816670503;1804.6661367646961;1860.897650629215;2108.167273926798;2152.160657343637;2208.6024515587187;2078.1271865816316;2158.3093410108772;2159.201095594632;2161.146347192858;2165.263810304496;2082.812546870789;2099.338708306886;2106;2116.9576608467896;2124.915003399862;2166;2172.7609962904066;2175.8803265820375;2176.836737244713;2182.8035476807163;7600.1639819619795;7619.123800762928;7625.809354766176;7643.0828300603725;7681.270279323456;4480.327950807405;4551.067031258584;4559.156556037144;4573.565511276457;4630.027694184226;2787.4007088475873;2900.4779139754837;2936.3393236521824;2940.220841476989;2964.659064207622;905.2079430498314;918.3709159225951;926.5459924636947;931.2410385535834;931.2689538712078;10169.54237059334;10205.285630005903;10210.2852800304;10216.335938163995;10225.079742823182;4013.4983127109113;4079.4900637420324;4245.087306229114;4255.1915136124035;4289.313709806478;8305.46014509067;8655.350848686374;8663.35024873137;8674.826503469896;8675.522846243517;4588.197065513588;4619.653525985565;4624.5144259852905;4628.375169352094;4630.351750754897;4189.183109293658;4218.78906054696;4227.387028880857;4228.619424251832;4231.174920890458;3483.7909725416557;3558.964410355915;3621.9496346059873;3666.450032495147;3682.5580930288;1032.9431881246453;1097.358045543366;1105.8285965675334;1127.7124333295121;1154.717094311899;686.8454597715574;787.4015748031537;797.5892415405955;801.5671537369755;832.6211573733937;4750.691205071659;4938.975305123451;4940;4998.2002879539095;5118.232265160255;862.2541501601195;863.7020228021448;871.2202578692035;879.6393478673841;894.6153154143781;3207.4066297734994;3254.5769050023346;3388.796672199676;3429.794212347267;3569.428891377367;8458.534780587126;8552.828943421096;8657.177568131017;8687.782805429788;8764.386492945432;8786.583689485442;8790.956045219733;8795.956020219857;8796.428232164888;8800.339974501938;6673.598544305653;6836.589804611739;6861.93639985803;6866.690998905061;6868.656567171622;4951.727654978867;5025.974870125626;5032.6225533084435;5202.557782588371;5258.526732593932;8309.83380332378;8328.167183281867;8425.4944703318;8432.156784321518;8503.617337219715;8148.266656000988;8473.110323416198;8507.617157228064;8606.096359882373;8741.475511469333;6312.715927783169;6442.452391546771;6453.257875344396;6456.709448074942;6462.159919210472;6757.256701762703;6766.695498702472;6796.116504854337;6830.7609233676585;6939.893965568586;4961.355023846877;6412.422881940461;6436.742530298736;6442.194725659293;6529.804105876831;6372.07604897278;6385.553011289165;6392.680365981775;6397.96801015992;6446.323136070645;5742.540596752333;5775;5826.941730582809;5879.029960056543;5895.64626122434;4406.713563618355;4413.2276851550205;4425.358323043205;4488.394066801071;4576.107659006462;4509.3686883835635;4519.457665080211;4561.064981678815;4561.110583436198;4734.8342808002935 12:20:27 INFO - PROCESS | 22644 | |4;prototype.html;284.30912881697475;285.70572310520157;300.5506767382763;302.1871166561948;305.70804881338324;4663.2538793793;4804.327394164811;4846.40240522197;4882.951170488294;4894.388201474816;4583.954160458395;4708.670393072486;4717.9056418871605;4726.85819425417;4735.266033764772;3737.906552336186;3740.4389341598776;3753.6246375362516;3757.4551690004932;3766.9058273543105;3512.490688850115;3668.4497325401135;3758.7180961427866;3788.109794198361;3790.2419516096893;3632.219072899326;3703.5185425894597;3718.814059297038;3722.7580207286574;3726.962730372702;3706.4810926470313;3722.8138593070507;3729.9627003730025;3748.6813620842263;3753.9812300938593;3316.8673253069846;3316.950245746316;3324.6010478742464;3328.6172090209693;3333.399988002159;4453.777311134463;4603.8158473661015;4640.396748422717;4649.139909116824;4746.620270378361;4250.489941207075;4254.936175957332;4257.212415703105;4257.574242575749;4272.722273052273;4993.228758039287;5018.519536736671;5029.974850125726;5037.244413337992;5050.116229659831;3359.6136444308972;3560.1099725068734;3630.564332280117;3637.9818100909592;3655.1593133579427;5197.180986654678;5204.193350030751;5210.635255532115;5233.895322093575;5246.554042906358;3626.238489917147;3640.908977275589;3642.1258897864323;3667.2482141161;3667.9266414671556;3711.573169085536;3722.7952462614276;3728.086618778362;3733.197362567061;3741.044574785943;4165.375193720966;4179;4207.76857272853;4210.431591735138;4211.778584210606;4973.32860063894;4984.975075124601;4987.850364489072;4990;4991.376077990251;1169.3977601535216;1206.2641788509002;1241.1746188784539;1257.792464243408;1272.5609664665676;844.2022288936896;857.6355049104105;881.3918396306528;882.5322579033123;885.4819930340694;4301.741895486218;4302.784860757012;4352.281873490839;4414.426124603781;4417.624501917308;5128.743562821844;5131.56381707559;5137.948620513822;5170.3278573785165;5172.637915345965;4343.783740552651;4359.520452750195;4359.738415695068;4361.345798130305;4374.475062992461;2306.7774079737765;2400.627902675088;2411.697683251025;2412.963805542918;2436.4639779248537;4246.4691913510815;4249.957500425018;4252.681048921281;4263.296556068276;4281.914361712748;4590.334401511762;4607.866650677572;4618.468876079294;4626.930596041062;4634.58288754007;4079.5925405734974;4214.4099826024385;4253.979674431189;4262.3180291153885;4264.1471705659;4509.23343031692;4510.819567217274;4511.842085527122;4515.035959357559;4519.90960180788;4400.669949753717;4412.11757648478;4418.955810441983;4429.623482004065;4440.866773996785;4209.789510524401;4244.915101697887;4258.914821703611;4478.552144785495;4853.587445067209;3693.095191678056;3766.7363284569815;3777.20678657485;3792.943105853359;3795.5824859266013;4963.9007219854675;5204.219367094966;5205.516427818054;5210.791568337224;5219.217117432264;4897.191963326154;5010.949890501194;5042.747862606929;5050.62620568347;5082.771275292546;5053.140966035856;5063.3417655704525;5066.544011039025;5072.315237442898;5091.847244582668;4883.754642566265;4996.875078123076;5002.124628189979;5022.698638081727;5051.242313652834;5033.672811267256;5061.493850614909;5064.696118232918;5067.214581739836;5070.062038522885;4968.577670897869;4983.152864013199;4996.725180115129;5007.649464537448;5009.5992320615 12:20:27 INFO - PROCESS | 22644 | |5;yui.html;649.3765984654731;688.6419062087715;689.4174422612892;715.7387553542952;716.6452605960051;12218.45016974236;13049.151805132684;13049.67375815605;13060.608181754562;13119.14725542839;13077.67305817355;13137.357830271216;13287.069905106646;13291.468341266338;13297.202167869935;769.6882762481204;787.3661702329622;795.2564352330561;795.2921899509412;796.2753893956501;634.8825467288543;650.8112647332268;651.133991790917;653.9836504087389;799.3964556759638;682.0519477925687;784.3842583571898;814.4339683919649;825.9752207433787;835.0563862835019;836.3225787112428;836.5649862071689;836.623519416259;836.6653338664522;837.7696133563257;609.881073190728;609.9786507472218;610.6244659534399;610.6946526736632;610.8656095658948;10081.949590252001;10544.472776361228;12359.505619775198;12878.29169395683;12947.352632368438;12952.935235323857;13361.799573006412;13503.864961350457;13642;13943.860561394458;10597.894021059768;10658.840117398246;10678.51946662402;10726.356418614909;11152.888471115266;3268.444364458024;3283.7865538740143;3324.833758312099;3421.6578342165835;3439.1574064354145;61622;63197;63241.367586324006;63243.683781581254;63968;10249.897501025043;10274.434906080089;10310;10378.896211037792;10386.844197337046;20248.088836002415;20263.29078482246;20409.48976275605;20678.379648610568;20765.58468830615;6690.732370705215;6741.7303307868115;6764.323567643295;6837.931620683829;7085.681144348517;3637.5089362935664;3670.1925576373155;3671.30245253401;3728.7017038636845;3746.213295208037;3094.071778466451;3191.9042428727175;3205.054508919874;3205.35892821432;3209.4704373778063;474.28619927010317;491.4913064977802;491.6558409113635;493.88393727474016;499.4306490600718;606.3542327421283;630.5145038320468;632.4150161101055;640.8494003909078;649.1172006071739;7848.882266766003;8141.226583474679;8249.422540422112;8313.293370063613;8317.667293308321;573.4380307298787;590.8345663214307;595.3362001368444;600.555588864246;609.5062998970848;3959.5842436544326;4007.7996100194873;4048.332025215865;4099.508059032935;4156.459660244149;96339;96973.84800748005;99589;99714;100278.49860750795;62717;63249.36750632527;64863.67568162223;72574.63712681402;75538;64897.51024897472;66379;68115.3188468109;68479.65760171067;68620.6568967152;8038.316743076904;8749.562521873753;8770.605322760619;8837.337199709918;9005.279577633642;39778.40332395074;40012;40296;40444.1911161781;41683.58316416797;33990.15024624305;34685.65314346824;35061.47407788834;35450.468242976895;37215.25569488541;10954.671359859218;11019.944900275448;11348.716282093013;11382.54469821198;11551.942240289081;12145.332006739714;12566.926457134836;12768.936155319165;13405.463781448632;13615.659608509866;11395.829062564235;11856.881431185922;11920.940395297968;12067.939660301643;12077.335746534025;11644.825327620261;12214.239706683913;12227.266364018187;12290.262584244974;12411.083395402255;11042.613508527164;12452.003839692985;12452.439640216031;12476.812847807472;12501;9457.43255404678;9523.190528804853;9982.201423886218;10092.94953525257;10195.184385249015;9781.755456113655;10136.061544290944;10160.847587286344;10219.540120694735;10322.432266225129 12:20:27 INFO - PROCESS | 22644 | __end_tp_report 12:20:27 INFO - PROCESS | 22644 | __start_cc_report 12:20:27 INFO - PROCESS | 22644 | _x_x_mozilla_cycle_collect,1071 12:20:27 INFO - PROCESS | 22644 | __end_cc_report 12:20:27 INFO - PROCESS | 22644 | __startTimestamp1476472827612__endTimestamp 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | ------- Summary: start ------- 12:20:27 INFO - PROCESS | 22644 | Number of tests: 6 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | [#0] dojo.html Cycles:165 Average:4738.91 Median:4840.69 stddev:501.74 (10.4%) stddev-sans-first:474.25 12:20:27 INFO - PROCESS | 22644 | Values: 2594.9 2613.0 2641.2 2650.3 2659.1 4601.9 4691.9 4773.5 4788.6 4813.0 4724.4 4729.5 4773.5 4823.4 4890.2 4334.7 4419.2 4428.1 4437.0 4448.9 4407.5 4416.6 4422.4 4441.3 4443.9 4422.7 4447.9 4481.4 4482.6 4515.1 4288.7 4333.3 4345.2 4385.0 4386.3 4322.4 4356.0 4365.4 4365.7 4367.9 4749.8 4751.3 4767.7 4788.0 4835.7 5174.7 5183.4 5195.3 5198.3 5262.0 5051.6 5119.8 5205.7 5212.4 5221.8 4777.3 4795.3 4813.8 4840.2 4877.2 5258.0 5268.8 5291.8 5296.2 5351.7 4950.0 5100.7 5122.0 5128.6 5134.4 5039.3 5048.3 5048.4 5061.2 5140.8 4992.8 5045.8 5045.9 5098.8 5108.5 5023.8 5029.2 5029.6 5032.6 5097.9 4298.1 4331.1 4340.3 4349.3 4376.3 3842.5 3851.8 3881.2 3919.8 3939.9 4363.9 4379.6 4386.0 4386.8 4437.6 4959.3 5051.2 5180.0 5197.5 5199.1 4323.1 4345.0 4378.1 4379.7 4450.8 4665.5 4671.4 4672.6 4673.7 4735.1 4698.0 4831.9 4838.9 4840.3 4899.6 5090.3 5117.9 5118.3 5152.4 5171.2 4779.8 4785.5 4791.6 4829.8 4846.3 5050.0 5054.9 5055.2 5055.8 5062.2 5006.3 5105.0 5115.2 5144.3 5158.9 4976.3 4977.5 4980.3 4993.5 5040.7 5011.7 5017.5 5018.6 5026.5 5074.1 4840.7 4885.8 4924.4 4948.8 4999.4 5077.9 5078.5 5087.9 5117.8 5121.1 4830.1 4936.8 4974.9 4976.8 5037.1 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | [#1] ext.html Cycles:180 Average:36638.85 Median:19341.35 stddev:54920.19 (284.0%) stddev-sans-first:55007.44 12:20:27 INFO - PROCESS | 22644 | Values: 558.7 580.3 582.6 582.7 593.6 27545.6 37206.4 38511.8 38637.4 43435.3 39334.6 39707.2 39741.4 39812.8 39855.6 7434.9 7586.1 7588.0 7598.0 7600.9 7505.7 7588.6 7591.3 7597.7 7600.4 7541.2 7568.5 7597.5 7602.6 7608.1 7487.7 7488.4 7541.0 7550.3 7588.8 7594.2 7650.8 7655.6 7659.5 7659.6 35783.1 36083.3 36086.6 36111.8 36116.3 3027.5 3209.2 3621.9 3660.4 3672.9 27515.6 27908.2 28315.4 30163.9 30987.7 3551.7 3552.7 3558.4 3575.4 3621.9 238289.0 239426.5 239667.0 240377.0 241307.0 53976.0 54552.5 54588.0 54605.5 54638.2 32534.0 33586.0 33600.5 57607.0 57882.0 14455.3 14473.3 14669.0 14670.1 14676.3 10539.2 10783.3 10787.0 10789.1 10791.7 17749.8 17969.5 17974.6 17980.2 18039.5 6858.8 6867.2 6946.0 7030.2 7105.6 615.8 689.8 698.8 749.3 760.9 25923.9 26167.7 26260.7 27620.6 27629.0 892.7 896.0 917.2 917.8 931.6 14207.9 14281.5 14492.9 14498.4 14791.0 110733.4 111731.4 112354.0 112429.0 112430.4 47587.8 48290.3 48290.8 48341.0 48376.0 1042.9 1106.7 1147.1 1154.8 1195.0 26939.6 28009.7 28493.6 28884.2 29375.6 40782.0 40959.6 41129.0 41205.4 41237.8 248278.0 248918.0 249533.0 250193.0 250350.0 21673.8 22166.0 22241.4 24948.6 25759.0 39062.4 39505.0 39537.4 39682.6 39907.0 33971.3 34396.0 34742.8 34811.1 34815.5 33363.0 33409.8 34014.5 34501.8 34883.3 34419.3 34573.8 34816.7 34915.7 35131.0 27440.6 27521.2 31979.5 32082.1 32533.3 24395.5 24459.0 24853.8 24939.4 25009.7 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | [#2] jquery.html Cycles:180 Average:23396.76 Median:197119.14 stddev:58510.10 (29.7%) stddev-sans-first:58648.66 12:20:27 INFO - PROCESS | 22644 | Values: 354.1 357.0 359.0 373.1 380.7 15284.5 16317.3 16718.2 16828.2 16833.2 15991.4 16575.6 17027.4 17154.1 17214.0 4707.3 4926.1 4968.7 4978.9 4981.3 3615.5 3816.0 4876.5 5466.3 5831.1 5801.3 5926.6 5935.6 5995.5 6003.3 5717.3 5861.2 5890.8 5897.6 5903.2 4965.7 5170.6 5177.0 5179.5 5179.5 21127.0 21631.8 21759.2 21878.6 21917.5 1873.7 1906.5 1918.7 1947.6 2373.4 12660.7 12733.7 13134.8 13801.7 13821.3 1673.2 1680.7 1697.4 1709.4 1766.2 65820.7 69004.0 69333.0 69761.7 71032.0 9422.9 9446.4 9766.2 9839.3 10001.4 13301.8 13309.7 13318.1 13329.5 13336.4 7140.1 7321.3 7401.4 7445.9 7538.0 7005.9 7045.4 7100.6 7241.2 7257.4 6007.4 6079.2 6154.4 6194.5 6279.6 1559.4 1687.1 1696.4 1697.3 1711.8 762.5 835.6 838.2 867.6 868.8 17666.8 18806.7 19057.5 19079.0 19273.6 883.4 890.3 894.5 896.0 920.1 9987.2 10518.9 10541.6 10635.8 10677.5 349450.0 354357.0 354730.0 355239.0 358369.0 44987.1 62688.4 76448.2 78215.0 78701.6 942.8 993.6 1003.2 1004.9 1012.8 15705.5 16370.6 16621.5 16756.6 16833.7 35761.6 35869.3 36666.6 36828.2 37516.2 45453.5 48125.0 50384.0 51360.7 52067.0 7707.4 7806.3 7825.8 7839.8 7938.3 12480.2 12580.9 12736.7 12811.6 13108.7 10441.4 10752.1 10769.6 11009.8 11018.6 10643.7 10687.2 10736.7 11182.8 11251.5 10991.3 11134.4 11141.9 11165.8 11819.7 7615.6 7773.0 7887.1 7992.7 8042.8 9858.6 10368.8 11037.0 11227.7 11526.3 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | [#3] mootools.html Cycles:180 Average:4892.08 Median:5012.09 stddev:2658.69 (53.0%) stddev-sans-first:2652.87 12:20:27 INFO - PROCESS | 22644 | Values: 1355.9 1396.6 1473.6 1661.2 1715.9 6487.4 6696.3 7134.8 7699.7 7727.2 7102.8 7369.9 7396.9 7612.1 7625.2 2143.8 2165.1 2167.9 2171.4 2173.3 1804.7 1860.9 2108.2 2152.2 2208.6 2078.1 2158.3 2159.2 2161.1 2165.3 2082.8 2099.3 2106.0 2117.0 2124.9 2166.0 2172.8 2175.9 2176.8 2182.8 7600.2 7619.1 7625.8 7643.1 7681.3 4480.3 4551.1 4559.2 4573.6 4630.0 2787.4 2900.5 2936.3 2940.2 2964.7 905.2 918.4 926.5 931.2 931.3 10169.5 10205.3 10210.3 10216.3 10225.1 4013.5 4079.5 4245.1 4255.2 4289.3 8305.5 8655.4 8663.4 8674.8 8675.5 4588.2 4619.7 4624.5 4628.4 4630.4 4189.2 4218.8 4227.4 4228.6 4231.2 3483.8 3559.0 3621.9 3666.5 3682.6 1032.9 1097.4 1105.8 1127.7 1154.7 686.8 787.4 797.6 801.6 832.6 4750.7 4939.0 4940.0 4998.2 5118.2 862.3 863.7 871.2 879.6 894.6 3207.4 3254.6 3388.8 3429.8 3569.4 8458.5 8552.8 8657.2 8687.8 8764.4 8786.6 8791.0 8796.0 8796.4 8800.3 6673.6 6836.6 6861.9 6866.7 6868.7 4951.7 5026.0 5032.6 5202.6 5258.5 8309.8 8328.2 8425.5 8432.2 8503.6 8148.3 8473.1 8507.6 8606.1 8741.5 6312.7 6442.5 6453.3 6456.7 6462.2 6757.3 6766.7 6796.1 6830.8 6939.9 4961.4 6412.4 6436.7 6442.2 6529.8 6372.1 6385.6 6392.7 6398.0 6446.3 5742.5 5775.0 5826.9 5879.0 5895.6 4406.7 4413.2 4425.4 4488.4 4576.1 4509.4 4519.5 4561.1 4561.1 4734.8 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | [#4] prototype.html Cycles:180 Average:4058.76 Median:4387.57 stddev:1175.06 (26.8%) stddev-sans-first:1143.69 12:20:27 INFO - PROCESS | 22644 | Values: 284.3 285.7 300.6 302.2 305.7 4663.3 4804.3 4846.4 4883.0 4894.4 4584.0 4708.7 4717.9 4726.9 4735.3 3737.9 3740.4 3753.6 3757.5 3766.9 3512.5 3668.4 3758.7 3788.1 3790.2 3632.2 3703.5 3718.8 3722.8 3727.0 3706.5 3722.8 3730.0 3748.7 3754.0 3316.9 3317.0 3324.6 3328.6 3333.4 4453.8 4603.8 4640.4 4649.1 4746.6 4250.5 4254.9 4257.2 4257.6 4272.7 4993.2 5018.5 5030.0 5037.2 5050.1 3359.6 3560.1 3630.6 3638.0 3655.2 5197.2 5204.2 5210.6 5233.9 5246.6 3626.2 3640.9 3642.1 3667.2 3667.9 3711.6 3722.8 3728.1 3733.2 3741.0 4165.4 4179.0 4207.8 4210.4 4211.8 4973.3 4985.0 4987.9 4990.0 4991.4 1169.4 1206.3 1241.2 1257.8 1272.6 844.2 857.6 881.4 882.5 885.5 4301.7 4302.8 4352.3 4414.4 4417.6 5128.7 5131.6 5137.9 5170.3 5172.6 4343.8 4359.5 4359.7 4361.3 4374.5 2306.8 2400.6 2411.7 2413.0 2436.5 4246.5 4250.0 4252.7 4263.3 4281.9 4590.3 4607.9 4618.5 4626.9 4634.6 4079.6 4214.4 4254.0 4262.3 4264.1 4509.2 4510.8 4511.8 4515.0 4519.9 4400.7 4412.1 4419.0 4429.6 4440.9 4209.8 4244.9 4258.9 4478.6 4853.6 3693.1 3766.7 3777.2 3792.9 3795.6 4963.9 5204.2 5205.5 5210.8 5219.2 4897.2 5010.9 5042.7 5050.6 5082.8 5053.1 5063.3 5066.5 5072.3 5091.8 4883.8 4996.9 5002.1 5022.7 5051.2 5033.7 5061.5 5064.7 5067.2 5070.1 4968.6 4983.2 4996.7 5007.6 5009.6 12:20:27 INFO - PROCESS | 22644 | 12:20:27 INFO - PROCESS | 22644 | [#5] yui.html Cycles:180 Average:16382.10 Median:22151.90 stddev:22763.57 (102.8%) stddev-sans-first:22796.78 12:20:27 INFO - PROCESS | 22644 | Values: 649.4 688.6 689.4 715.7 716.6 12218.5 13049.2 13049.7 13060.6 13119.1 13077.7 13137.4 13287.1 13291.5 13297.2 769.7 787.4 795.3 795.3 796.3 634.9 650.8 651.1 654.0 799.4 682.1 784.4 814.4 826.0 835.1 836.3 836.6 836.6 836.7 837.8 609.9 610.0 610.6 610.7 610.9 10081.9 10544.5 12359.5 12878.3 12947.4 12952.9 13361.8 13503.9 13642.0 13943.9 10597.9 10658.8 10678.5 10726.4 11152.9 3268.4 3283.8 3324.8 3421.7 3439.2 61622.0 63197.0 63241.4 63243.7 63968.0 10249.9 10274.4 10310.0 10378.9 10386.8 20248.1 20263.3 20409.5 20678.4 20765.6 6690.7 6741.7 6764.3 6837.9 7085.7 3637.5 3670.2 3671.3 3728.7 3746.2 3094.1 3191.9 3205.1 3205.4 3209.5 474.3 491.5 491.7 493.9 499.4 606.4 630.5 632.4 640.8 649.1 7848.9 8141.2 8249.4 8313.3 8317.7 573.4 590.8 595.3 600.6 609.5 3959.6 4007.8 4048.3 4099.5 4156.5 96339.0 96973.8 99589.0 99714.0 100278.5 62717.0 63249.4 64863.7 72574.6 75538.0 64897.5 66379.0 68115.3 68479.7 68620.7 8038.3 8749.6 8770.6 8837.3 9005.3 39778.4 40012.0 40296.0 40444.2 41683.6 33990.2 34685.7 35061.5 35450.5 37215.3 10954.7 11019.9 11348.7 11382.5 11551.9 12145.3 12566.9 12768.9 13405.5 13615.7 11395.8 11856.9 11920.9 12067.9 12077.3 11644.8 12214.2 12227.3 12290.3 12411.1 11042.6 12452.0 12452.4 12476.8 12501.0 9457.4 9523.2 9982.2 10092.9 10195.2 9781.8 10136.1 10160.8 10219.5 10322.4 12:20:27 INFO - PROCESS | 22644 | -------- Summary: end -------- 12:20:27 INFO - PROCESS | 22644 | 12:20:28 INFO - TEST-INFO | 22644: exit 0 12:20:28 INFO - TEST-OK | dromaeo_css | took 1122844ms 12:20:28 INFO - TEST-START | kraken 12:20:28 INFO - operating with platform_type : linux_ 12:20:28 INFO - Initialising browser for kraken test... 12:20:28 INFO - TEST-INFO | started process 22952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdC7TS/profile http://localhost:49455/getInfo.html) 12:20:32 INFO - PROCESS | 22952 | __metrics Screen width/height:1600/1200 12:20:32 INFO - PROCESS | 22952 | colorDepth:24 12:20:32 INFO - PROCESS | 22952 | Browser inner width/height: 1024/697 12:20:32 INFO - PROCESS | 22952 | __metrics 12:20:33 INFO - PROCESS | 22952 | 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" 12:20:33 INFO - PROCESS | 22952 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:20:33 INFO - PROCESS | 22952 | console.error: PushService: 12:20:33 INFO - PROCESS | 22952 | stateChangeProcessEnqueue: Error transitioning state 12:20:33 INFO - PROCESS | 22952 | UnknownError 12:20:34 INFO - TEST-INFO | 22952: exit 0 12:20:34 INFO - Browser initialized. 12:20:34 INFO - Running cycle 1/1 for kraken test... 12:20:34 INFO - TEST-INFO | started process 23036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdC7TS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:46 INFO - PROCESS | 23036 | RSS: Main: 173723648 12:20:46 INFO - PROCESS | 23036 | 12:20:49 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49455/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:50 INFO - PROCESS | 23036 | RSS: Main: 230789120 12:20:50 INFO - PROCESS | 23036 | 12:20:53 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49455/tests/kraken/driver.html?testName=audio-dft) 12:20:54 INFO - PROCESS | 23036 | RSS: Main: 217567232 12:20:54 INFO - PROCESS | 23036 | 12:20:57 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49455/tests/kraken/driver.html?testName=audio-fft) 12:20:58 INFO - PROCESS | 23036 | RSS: Main: 299565056 12:20:58 INFO - PROCESS | 23036 | 12:21:00 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49455/tests/kraken/driver.html?testName=audio-oscillator) 12:21:00 INFO - PROCESS | 23036 | RSS: Main: 210190336 12:21:00 INFO - PROCESS | 23036 | 12:21:03 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:21:03 INFO - PROCESS | 23036 | RSS: Main: 213442560 12:21:03 INFO - PROCESS | 23036 | 12:21:06 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49455/tests/kraken/driver.html?testName=imaging-darkroom) 12:21:07 INFO - PROCESS | 23036 | RSS: Main: 249057280 12:21:07 INFO - PROCESS | 23036 | 12:21:10 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49455/tests/kraken/driver.html?testName=imaging-desaturate) 12:21:11 INFO - PROCESS | 23036 | RSS: Main: 243134464 12:21:11 INFO - PROCESS | 23036 | 12:21:14 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49455/tests/kraken/driver.html?testName=json-parse-financial) 12:21:14 INFO - PROCESS | 23036 | RSS: Main: 246136832 12:21:14 INFO - PROCESS | 23036 | 12:21:16 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:21:17 INFO - PROCESS | 23036 | RSS: Main: 209530880 12:21:17 INFO - PROCESS | 23036 | 12:21:19 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:21:19 INFO - PROCESS | 23036 | RSS: Main: 217587712 12:21:19 INFO - PROCESS | 23036 | 12:21:22 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:21:22 INFO - PROCESS | 23036 | RSS: Main: 225812480 12:21:22 INFO - PROCESS | 23036 | 12:21:25 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:21:26 INFO - PROCESS | 23036 | RSS: Main: 234856448 12:21:26 INFO - PROCESS | 23036 | 12:21:29 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:21:29 INFO - PROCESS | 23036 | RSS: Main: 231514112 12:21:29 INFO - PROCESS | 23036 | 12:21:31 INFO - PROCESS | 23036 | Cycle 1(1): loaded http://localhost:49455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49455/tests/kraken/driver.html?testName=ai-astar) 12:21:32 INFO - PROCESS | 23036 | RSS: Main: 281575424 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | __start_tp_report 12:21:32 INFO - PROCESS | 23036 | _x_x_mozilla_page_load 12:21:32 INFO - PROCESS | 23036 | _x_x_mozilla_page_load_details 12:21:32 INFO - PROCESS | 23036 | |i|pagename|runs| 12:21:32 INFO - PROCESS | 23036 | |0;ai-astar;109;115;116;114;116;116;115;115;115;114 12:21:32 INFO - PROCESS | 23036 | |1;audio-beat-detection;154;130;136;177;133;136;127;130;178;129 12:21:32 INFO - PROCESS | 23036 | |2;audio-dft;161;162;161;163;162;163;162;163;164;161 12:21:32 INFO - PROCESS | 23036 | |3;audio-fft;79;77;85;107;78;79;79;79;104;79 12:21:32 INFO - PROCESS | 23036 | |4;audio-oscillator;85;84;119;84;86;83;105;84;85;115 12:21:32 INFO - PROCESS | 23036 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;117;119;116 12:21:32 INFO - PROCESS | 23036 | |6;imaging-darkroom;148;146;146;147;148;146;147;147;147;146 12:21:32 INFO - PROCESS | 23036 | |7;imaging-desaturate;84;84;84;86;85;85;85;84;85;84 12:21:32 INFO - PROCESS | 23036 | |8;json-parse-financial;66;65;66;66;66;68;68;68;67;67 12:21:32 INFO - PROCESS | 23036 | |9;json-stringify-tinderbox;68;69;68;68;70;69;70;69;70;68 12:21:32 INFO - PROCESS | 23036 | |10;stanford-crypto-aes;84;82;92;87;85;84;87;83;92;83 12:21:32 INFO - PROCESS | 23036 | |11;stanford-crypto-ccm;152;142;140;139;141;139;154;140;183;155 12:21:32 INFO - PROCESS | 23036 | |12;stanford-crypto-pbkdf2;182;182;182;174;176;178;177;176;181;179 12:21:32 INFO - PROCESS | 23036 | |13;stanford-crypto-sha256-iterative;72;75;72;72;72;74;71;75;70;70 12:21:32 INFO - PROCESS | 23036 | __end_tp_report 12:21:32 INFO - PROCESS | 23036 | __start_cc_report 12:21:32 INFO - PROCESS | 23036 | _x_x_mozilla_cycle_collect,1999 12:21:32 INFO - PROCESS | 23036 | __end_cc_report 12:21:32 INFO - PROCESS | 23036 | __startTimestamp1476472892018__endTimestamp 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | ------- Summary: start ------- 12:21:32 INFO - PROCESS | 23036 | Number of tests: 14 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.07 (1.8%) stddev-sans-first:0.78 12:21:32 INFO - PROCESS | 23036 | Values: 109.0 115.0 116.0 114.0 116.0 116.0 115.0 115.0 115.0 114.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:136.00 stddev:19.69 (14.5%) stddev-sans-first:20.48 12:21:32 INFO - PROCESS | 23036 | Values: 154.0 130.0 136.0 177.0 133.0 136.0 127.0 130.0 178.0 129.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 12:21:32 INFO - PROCESS | 23036 | Values: 161.0 162.0 161.0 163.0 162.0 163.0 162.0 163.0 164.0 161.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#3] audio-fft Cycles:10 Average:84.60 Median:79.00 stddev:11.24 (14.2%) stddev-sans-first:11.73 12:21:32 INFO - PROCESS | 23036 | Values: 79.0 77.0 85.0 107.0 78.0 79.0 79.0 79.0 104.0 79.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:84.00 stddev:14.24 (16.9%) stddev-sans-first:14.80 12:21:32 INFO - PROCESS | 23036 | Values: 85.0 84.0 119.0 84.0 86.0 83.0 105.0 84.0 85.0 115.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 12:21:32 INFO - PROCESS | 23036 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 119.0 116.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 12:21:32 INFO - PROCESS | 23036 | Values: 148.0 146.0 146.0 147.0 148.0 146.0 147.0 147.0 147.0 146.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 12:21:32 INFO - PROCESS | 23036 | Values: 84.0 84.0 84.0 86.0 85.0 85.0 85.0 84.0 85.0 84.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 12:21:32 INFO - PROCESS | 23036 | Values: 66.0 65.0 66.0 66.0 66.0 68.0 68.0 68.0 67.0 67.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 12:21:32 INFO - PROCESS | 23036 | Values: 68.0 69.0 68.0 68.0 70.0 69.0 70.0 69.0 70.0 68.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:3.60 (4.2%) stddev-sans-first:3.76 12:21:32 INFO - PROCESS | 23036 | Values: 84.0 82.0 92.0 87.0 85.0 84.0 87.0 83.0 92.0 83.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:147.00 stddev:13.74 (9.3%) stddev-sans-first:14.51 12:21:32 INFO - PROCESS | 23036 | Values: 152.0 142.0 140.0 139.0 141.0 139.0 154.0 140.0 183.0 155.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:180.00 stddev:2.95 (1.6%) stddev-sans-first:2.87 12:21:32 INFO - PROCESS | 23036 | Values: 182.0 182.0 182.0 174.0 176.0 178.0 177.0 176.0 181.0 179.0 12:21:32 INFO - PROCESS | 23036 | 12:21:32 INFO - PROCESS | 23036 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:1.83 (2.5%) stddev-sans-first:1.94 12:21:32 INFO - PROCESS | 23036 | Values: 72.0 75.0 72.0 72.0 72.0 74.0 71.0 75.0 70.0 70.0 12:21:32 INFO - PROCESS | 23036 | -------- Summary: end -------- 12:21:32 INFO - PROCESS | 23036 | 12:21:33 INFO - TEST-INFO | 23036: exit 0 12:21:33 INFO - TEST-OK | kraken | took 64868ms 12:21:33 INFO - SUITE-END | took 1187s 12:21:33 INFO - Completed test suite (00:19:47) 12:21:33 INFO - javascript benchmark 12:21:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.935126621834, 2612.9869350653244, 2641.234042127783, 2650.2579277802224, 2659.0693257359926, 4601.861944141673, 4691.859244222679, 4773.474917759048, 4788.616910647149, 4813.0, 4724.3622111015, 4729.503402142777, 4773.5226477352335, 4823.372961514998, 4890.168671325874, 4334.718243314191, 4419.182451246514, 4428.092241090585, 4437.046035102452, 4448.888777780565, 4407.537208593099, 4416.5583441655735, 4422.425084738979, 4441.2893936970095, 4443.866683999485, 4422.690411671184, 4447.866564003085, 4481.417415735949, 4482.596566309048, 4515.074409745994, 4288.656907447396, 4333.306670932636, 4345.1961387143165, 4384.9561504384865, 4386.254336762758, 4322.416473776031, 4356.019895523514, 4365.3670217818235, 4365.738055716635, 4367.890802729926, 4749.762511874427, 4751.3348131261655, 4767.69010014348, 4788.018456216468, 4835.685680430761, 5174.663646862942, 5183.403908550489, 5195.3246078009615, 5198.298229738974, 5262.0, 5051.570616497565, 5119.8208062717995, 5205.713685747282, 5212.374515058179, 5221.791128354861, 4777.3072904429355, 4795.328653988445, 4813.807447702053, 4840.152973229741, 4877.195262781602, 5258.0, 5268.789248430096, 5291.788328466895, 5296.232046353257, 5351.6788992659785, 4949.975250123798, 5100.744962751847, 5121.9743901281, 5128.640995130305, 5134.383873935151, 5039.344885164978, 5048.343715316985, 5048.419431765321, 5061.240813877874, 5140.845774626767, 4992.825251116194, 5045.84862454127, 5045.949540504548, 5098.821541246039, 5108.489151084936, 5023.824166154167, 5029.195328747456, 5029.622778291569, 5032.647714660012, 5097.898042039213, 4298.118885628439, 4331.068820203672, 4340.283853164193, 4349.28236840924, 4376.321670141133, 3842.51968503937, 3851.807409629507, 3881.1849511602313, 3919.7844118573753, 3939.9015024624614, 4363.890902727458, 4379.605835474823, 4386.0, 4386.780660966939, 4437.5784300491405, 4959.305697202394, 5051.217061355495, 5180.041692286939, 5197.532222100029, 5199.142141546678, 4323.113761678848, 4344.9565504344555, 4378.08060307339, 4379.693421460467, 4450.799714012877, 4665.533446655308, 4671.392718946583, 4672.556107169813, 4673.6728429009645, 4735.076660051326, 4698.0, 4831.879203019882, 4838.854834354975, 4840.34655321527, 4899.608031357411, 5090.338256026693, 5117.948820511896, 5118.283440318432, 5152.407473140637, 5171.224316352577, 4779.808807647655, 4785.545373189541, 4791.640626953063, 4829.830955916526, 4846.297286893451, 5050.04049230645, 5054.924176137288, 5055.191169412877, 5055.772490237875, 5062.190049592047, 5006.299118123393, 5104.9744751276, 5115.18157094863, 5144.331236939174, 5158.871028224325, 4976.278439626306, 4977.527134922177, 4980.27785971025, 4993.500649934977, 5040.697558146523, 5011.724355160502, 5017.498250174954, 5018.623603229846, 5026.547610715053, 5074.086664400444, 4840.685355451885, 4885.8045678172475, 4924.433690125681, 4948.777305021211, 4999.425066117443, 5077.949220507748, 5078.542931136216, 5087.898242035065, 5117.769700363567, 5121.103806833864, 4830.082284365959, 4936.827211047596, 4974.875628109182, 4976.800927962841, 5037.093323201712], "value": 4706.270793580843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6731761919277, 580.3152280309233, 582.5776312173674, 582.7465052702072, 593.5637306579666, 27545.58681619775, 37206.44190337147, 38511.807440962824, 38637.42043869344, 43435.34846977298, 39334.60665393345, 39707.205855882865, 39741.40387894184, 39812.80093599528, 39855.60144398555, 7434.925650743491, 7586.089669239672, 7588.0, 7598.012258406399, 7600.923990760105, 7505.737299194529, 7588.58262795546, 7591.316781489665, 7597.696092156307, 7600.353969912564, 7541.170471248159, 7568.545887246755, 7597.468177227596, 7602.619869006555, 7608.125065617442, 7487.737929172453, 7488.438367122488, 7540.962295188544, 7550.28272314132, 7588.848223035564, 7594.202608726115, 7650.770476885702, 7655.617219139021, 7659.540427574363, 7659.61701914902, 35783.10542236439, 36083.27833443316, 36086.63913360859, 36111.81944090289, 36116.277674446625, 3027.5307327364294, 3209.2297848516187, 3621.8732344368086, 3660.432632941872, 3672.8981305608477, 27515.58726619102, 27908.209179082132, 28315.433691326263, 30163.92134965905, 30987.690123098706, 3551.708700193996, 3552.715782737401, 3558.395072837624, 3575.4458059000895, 3621.9112147432897, 238289.0, 239426.45161935335, 239667.0, 240377.0, 241307.0, 53976.0, 54552.45447545553, 54588.0, 54605.45394546083, 54638.18042729362, 32534.0, 33586.0, 33600.49599256013, 57607.0, 57882.0, 14455.349509272108, 14473.348699308557, 14669.0, 14670.119792812466, 14676.339564719614, 10539.209559283085, 10783.299085559414, 10787.0, 10789.082927951054, 10791.676249712522, 17749.822501774815, 17969.472594829323, 17974.550636233937, 17980.19089140992, 18039.458816235532, 6858.759943401957, 6867.175938887365, 6945.992831039471, 7030.226675065739, 7105.644717764091, 615.8306465721962, 689.7965100295424, 698.7798843364324, 749.2582343480025, 760.9391248700201, 25923.870380647975, 26167.666160698656, 26260.73739262583, 27620.58569121465, 27629.032983845467, 892.6607889002267, 895.9820803583892, 917.2386918857333, 917.7522069041321, 931.5901003558413, 14207.85792142086, 14281.500147494788, 14492.927535362256, 14498.420063197354, 14791.0, 110733.44633276782, 111731.44134279276, 112354.0, 112429.0, 112430.43784781024, 47587.762061189474, 48290.27564586534, 48290.75854620775, 48341.0, 48376.0, 1042.9009244121796, 1106.7067227184803, 1147.0823341326904, 1154.7863645225493, 1194.9522019119486, 26939.595906061033, 28009.719902800713, 28493.572596410657, 28884.15419680887, 29375.55936660909, 40782.0, 40959.59040409558, 41129.0, 41205.381919270636, 41237.79381103075, 248278.0, 248918.0, 249533.0, 250193.0, 250350.0, 21673.783262167806, 22166.0, 22241.44396390103, 24948.625770613093, 25759.0, 39062.414063789634, 39505.0, 39537.406938895365, 39682.60317396789, 39907.0, 33971.320573587895, 34396.0, 34742.82628586841, 34811.129721757155, 34815.477767833, 33363.0, 33409.83295083509, 34014.48978265378, 34501.827490862386, 34883.30233395369, 34419.31161376708, 34573.827130864185, 34816.651833481345, 34915.65084349124, 35131.0, 27440.588391173747, 27521.17436476909, 31979.520307195875, 32082.11904666879, 32533.349333012735, 24395.51208975775, 24459.0, 24853.751462485143, 24939.35514721672, 25009.749902500742], "value": 16231.929020982967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.148273402467, 356.9875054373097, 358.97307701922364, 373.14735828631547, 380.7144641518861, 15284.465043723472, 16317.265723042461, 16718.164091795406, 16828.242729077192, 16833.242504087313, 15991.360345586192, 16575.585610359747, 17027.40404085857, 17154.142292885335, 17214.0, 4707.2939059141145, 4926.11329960607, 4968.70187788732, 4978.900421991558, 4981.252812078199, 3615.493830863681, 3816.0459885028745, 4876.487968763282, 5466.316710411179, 5831.067029275317, 5801.332846722638, 5926.644401335933, 5935.614185077978, 5995.460408563228, 6003.279606447232, 5717.342505611846, 5861.150133230679, 5890.823275301748, 5897.587168898201, 5903.232579764646, 4965.677230980011, 5170.6122040847085, 5176.974115129438, 5179.482051794828, 5179.507946745053, 21127.0, 21631.783682163135, 21759.23842665515, 21878.562428751335, 21917.452063698376, 1873.7002079667188, 1906.4852489827808, 1918.6642337590865, 1947.6007418479178, 2373.4303767095944, 12660.746785064339, 12733.745325093447, 13134.802977955338, 13801.654958626013, 13821.308934553232, 1673.1801417305555, 1680.747263207991, 1697.3634886917405, 1709.3931654262683, 1766.1610734900949, 65820.6708966457, 69004.0, 69332.99999999949, 69761.65119174423, 71032.0, 9422.90577094234, 9446.433214007182, 9766.169875560516, 9839.262055345878, 10001.399916005063, 13301.800472992913, 13309.66725831862, 13318.134321269086, 13329.466821327038, 13336.39986200604, 7140.143182817991, 7321.267873212742, 7401.444891633149, 7445.85108297831, 7537.9623101884135, 7005.859882802315, 7045.401140902978, 7100.60946647929, 7241.203467618558, 7257.439650475173, 6007.429294217042, 6079.240094988127, 6154.3845615438095, 6194.473469755121, 6279.591826531261, 1559.423013485018, 1687.12269619797, 1696.3892998520769, 1697.2616911643229, 1711.8117007129206, 762.5310434082999, 835.6323217784155, 838.1827717975048, 867.6355930509201, 868.8132051608934, 17666.823331766776, 18806.717899231524, 19057.523561911064, 19079.0, 19273.614527709367, 883.3728053082383, 890.3055616619048, 894.4588523942921, 895.9641614335484, 920.1350730313484, 9987.151092157103, 10518.947405262925, 10541.578336866593, 10635.840462393071, 10677.519511621995, 349450.0, 354357.0, 354730.0, 355239.0, 358369.0, 44987.10025799466, 62688.37311626917, 76448.23551764523, 78215.0, 78701.60649196718, 942.7743932887082, 993.5975929748463, 1003.2024540490182, 1004.9045340692622, 1012.8075665623508, 15705.450309239122, 16370.590735231239, 16621.50135495937, 16756.58108547296, 16833.747493787847, 35761.64238357583, 35869.28261434809, 36666.63333366632, 36828.237882158406, 37516.2496750058, 45453.54546454493, 48125.0, 50384.0, 51360.74319628378, 52067.0, 7707.421943354158, 7806.258405451473, 7825.843483130419, 7839.84320313602, 7938.285554300141, 12480.188787728768, 12580.937095314832, 12736.6815829605, 12811.615651530468, 13108.657063728424, 10441.425721585385, 10752.13001182919, 10769.62306319275, 11009.83485247738, 11018.559257629606, 10643.733906652396, 10687.198460115367, 10736.677899663022, 11182.776344472903, 11251.549938002716, 10991.340519568852, 11134.443277836237, 11141.888581114084, 11165.832512512481, 11819.704507387383, 7615.619219039137, 7772.961135194288, 7887.132415434183, 7992.724801630896, 8042.758717238492, 9858.55636496345, 10368.844467333147, 11037.0, 11227.66317010491, 11526.250793698382], "value": 8448.667997418632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.85763494833, 1396.6368744126528, 1473.5800296915381, 1661.1777170300702, 1715.8627309815215, 6487.44856687181, 6696.2634110247955, 7134.785956421303, 7699.730509432171, 7727.150013498518, 7102.822429439267, 7369.926300736991, 7396.852062958737, 7612.08654961404, 7625.237476252386, 2143.8499305048654, 2165.069020321261, 2167.8916054197307, 2171.381156370435, 2173.282816670503, 1804.6661367646961, 1860.897650629215, 2108.167273926798, 2152.160657343637, 2208.6024515587187, 2078.1271865816316, 2158.3093410108772, 2159.201095594632, 2161.146347192858, 2165.263810304496, 2082.812546870789, 2099.338708306886, 2106.0, 2116.9576608467896, 2124.915003399862, 2166.0, 2172.7609962904066, 2175.8803265820375, 2176.836737244713, 2182.8035476807163, 7600.1639819619795, 7619.123800762928, 7625.809354766176, 7643.0828300603725, 7681.270279323456, 4480.327950807405, 4551.067031258584, 4559.156556037144, 4573.565511276457, 4630.027694184226, 2787.4007088475873, 2900.4779139754837, 2936.3393236521824, 2940.220841476989, 2964.659064207622, 905.2079430498314, 918.3709159225951, 926.5459924636947, 931.2410385535834, 931.2689538712078, 10169.54237059334, 10205.285630005903, 10210.2852800304, 10216.335938163995, 10225.079742823182, 4013.4983127109113, 4079.4900637420324, 4245.087306229114, 4255.1915136124035, 4289.313709806478, 8305.46014509067, 8655.350848686374, 8663.35024873137, 8674.826503469896, 8675.522846243517, 4588.197065513588, 4619.653525985565, 4624.5144259852905, 4628.375169352094, 4630.351750754897, 4189.183109293658, 4218.78906054696, 4227.387028880857, 4228.619424251832, 4231.174920890458, 3483.7909725416557, 3558.964410355915, 3621.9496346059873, 3666.450032495147, 3682.5580930288, 1032.9431881246453, 1097.358045543366, 1105.8285965675334, 1127.7124333295121, 1154.717094311899, 686.8454597715574, 787.4015748031537, 797.5892415405955, 801.5671537369755, 832.6211573733937, 4750.691205071659, 4938.975305123451, 4940.0, 4998.2002879539095, 5118.232265160255, 862.2541501601195, 863.7020228021448, 871.2202578692035, 879.6393478673841, 894.6153154143781, 3207.4066297734994, 3254.5769050023346, 3388.796672199676, 3429.794212347267, 3569.428891377367, 8458.534780587126, 8552.828943421096, 8657.177568131017, 8687.782805429788, 8764.386492945432, 8786.583689485442, 8790.956045219733, 8795.956020219857, 8796.428232164888, 8800.339974501938, 6673.598544305653, 6836.589804611739, 6861.93639985803, 6866.690998905061, 6868.656567171622, 4951.727654978867, 5025.974870125626, 5032.6225533084435, 5202.557782588371, 5258.526732593932, 8309.83380332378, 8328.167183281867, 8425.4944703318, 8432.156784321518, 8503.617337219715, 8148.266656000988, 8473.110323416198, 8507.617157228064, 8606.096359882373, 8741.475511469333, 6312.715927783169, 6442.452391546771, 6453.257875344396, 6456.709448074942, 6462.159919210472, 6757.256701762703, 6766.695498702472, 6796.116504854337, 6830.7609233676585, 6939.893965568586, 4961.355023846877, 6412.422881940461, 6436.742530298736, 6442.194725659293, 6529.804105876831, 6372.07604897278, 6385.553011289165, 6392.680365981775, 6397.96801015992, 6446.323136070645, 5742.540596752333, 5775.0, 5826.941730582809, 5879.029960056543, 5895.64626122434, 4406.713563618355, 4413.2276851550205, 4425.358323043205, 4488.394066801071, 4576.107659006462, 4509.3686883835635, 4519.457665080211, 4561.064981678815, 4561.110583436198, 4734.8342808002935], "value": 3983.2603423978453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.30912881697475, 285.70572310520157, 300.5506767382763, 302.1871166561948, 305.70804881338324, 4663.2538793793, 4804.327394164811, 4846.40240522197, 4882.951170488294, 4894.388201474816, 4583.954160458395, 4708.670393072486, 4717.9056418871605, 4726.85819425417, 4735.266033764772, 3737.906552336186, 3740.4389341598776, 3753.6246375362516, 3757.4551690004932, 3766.9058273543105, 3512.490688850115, 3668.4497325401135, 3758.7180961427866, 3788.109794198361, 3790.2419516096893, 3632.219072899326, 3703.5185425894597, 3718.814059297038, 3722.7580207286574, 3726.962730372702, 3706.4810926470313, 3722.8138593070507, 3729.9627003730025, 3748.6813620842263, 3753.9812300938593, 3316.8673253069846, 3316.950245746316, 3324.6010478742464, 3328.6172090209693, 3333.399988002159, 4453.777311134463, 4603.8158473661015, 4640.396748422717, 4649.139909116824, 4746.620270378361, 4250.489941207075, 4254.936175957332, 4257.212415703105, 4257.574242575749, 4272.722273052273, 4993.228758039287, 5018.519536736671, 5029.974850125726, 5037.244413337992, 5050.116229659831, 3359.6136444308972, 3560.1099725068734, 3630.564332280117, 3637.9818100909592, 3655.1593133579427, 5197.180986654678, 5204.193350030751, 5210.635255532115, 5233.895322093575, 5246.554042906358, 3626.238489917147, 3640.908977275589, 3642.1258897864323, 3667.2482141161, 3667.9266414671556, 3711.573169085536, 3722.7952462614276, 3728.086618778362, 3733.197362567061, 3741.044574785943, 4165.375193720966, 4179.0, 4207.76857272853, 4210.431591735138, 4211.778584210606, 4973.32860063894, 4984.975075124601, 4987.850364489072, 4990.0, 4991.376077990251, 1169.3977601535216, 1206.2641788509002, 1241.1746188784539, 1257.792464243408, 1272.5609664665676, 844.2022288936896, 857.6355049104105, 881.3918396306528, 882.5322579033123, 885.4819930340694, 4301.741895486218, 4302.784860757012, 4352.281873490839, 4414.426124603781, 4417.624501917308, 5128.743562821844, 5131.56381707559, 5137.948620513822, 5170.3278573785165, 5172.637915345965, 4343.783740552651, 4359.520452750195, 4359.738415695068, 4361.345798130305, 4374.475062992461, 2306.7774079737765, 2400.627902675088, 2411.697683251025, 2412.963805542918, 2436.4639779248537, 4246.4691913510815, 4249.957500425018, 4252.681048921281, 4263.296556068276, 4281.914361712748, 4590.334401511762, 4607.866650677572, 4618.468876079294, 4626.930596041062, 4634.58288754007, 4079.5925405734974, 4214.4099826024385, 4253.979674431189, 4262.3180291153885, 4264.1471705659, 4509.23343031692, 4510.819567217274, 4511.842085527122, 4515.035959357559, 4519.90960180788, 4400.669949753717, 4412.11757648478, 4418.955810441983, 4429.623482004065, 4440.866773996785, 4209.789510524401, 4244.915101697887, 4258.914821703611, 4478.552144785495, 4853.587445067209, 3693.095191678056, 3766.7363284569815, 3777.20678657485, 3792.943105853359, 3795.5824859266013, 4963.9007219854675, 5204.219367094966, 5205.516427818054, 5210.791568337224, 5219.217117432264, 4897.191963326154, 5010.949890501194, 5042.747862606929, 5050.62620568347, 5082.771275292546, 5053.140966035856, 5063.3417655704525, 5066.544011039025, 5072.315237442898, 5091.847244582668, 4883.754642566265, 4996.875078123076, 5002.124628189979, 5022.698638081727, 5051.242313652834, 5033.672811267256, 5061.493850614909, 5064.696118232918, 5067.214581739836, 5070.062038522885, 4968.577670897869, 4983.152864013199, 4996.725180115129, 5007.649464537448, 5009.5992320615], "value": 3688.5017145614593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.3765984654731, 688.6419062087715, 689.4174422612892, 715.7387553542952, 716.6452605960051, 12218.45016974236, 13049.151805132684, 13049.67375815605, 13060.608181754562, 13119.14725542839, 13077.67305817355, 13137.357830271216, 13287.069905106646, 13291.468341266338, 13297.202167869935, 769.6882762481204, 787.3661702329622, 795.2564352330561, 795.2921899509412, 796.2753893956501, 634.8825467288543, 650.8112647332268, 651.133991790917, 653.9836504087389, 799.3964556759638, 682.0519477925687, 784.3842583571898, 814.4339683919649, 825.9752207433787, 835.0563862835019, 836.3225787112428, 836.5649862071689, 836.623519416259, 836.6653338664522, 837.7696133563257, 609.881073190728, 609.9786507472218, 610.6244659534399, 610.6946526736632, 610.8656095658948, 10081.949590252001, 10544.472776361228, 12359.505619775198, 12878.29169395683, 12947.352632368438, 12952.935235323857, 13361.799573006412, 13503.864961350457, 13642.0, 13943.860561394458, 10597.894021059768, 10658.840117398246, 10678.51946662402, 10726.356418614909, 11152.888471115266, 3268.444364458024, 3283.7865538740143, 3324.833758312099, 3421.6578342165835, 3439.1574064354145, 61622.0, 63197.0, 63241.367586324006, 63243.683781581254, 63968.0, 10249.897501025043, 10274.434906080089, 10310.0, 10378.896211037792, 10386.844197337046, 20248.088836002415, 20263.29078482246, 20409.48976275605, 20678.379648610568, 20765.58468830615, 6690.732370705215, 6741.7303307868115, 6764.323567643295, 6837.931620683829, 7085.681144348517, 3637.5089362935664, 3670.1925576373155, 3671.30245253401, 3728.7017038636845, 3746.213295208037, 3094.071778466451, 3191.9042428727175, 3205.054508919874, 3205.35892821432, 3209.4704373778063, 474.28619927010317, 491.4913064977802, 491.6558409113635, 493.88393727474016, 499.4306490600718, 606.3542327421283, 630.5145038320468, 632.4150161101055, 640.8494003909078, 649.1172006071739, 7848.882266766003, 8141.226583474679, 8249.422540422112, 8313.293370063613, 8317.667293308321, 573.4380307298787, 590.8345663214307, 595.3362001368444, 600.555588864246, 609.5062998970848, 3959.5842436544326, 4007.7996100194873, 4048.332025215865, 4099.508059032935, 4156.459660244149, 96339.0, 96973.84800748005, 99589.0, 99714.0, 100278.49860750795, 62717.0, 63249.36750632527, 64863.67568162223, 72574.63712681402, 75538.0, 64897.51024897472, 66379.0, 68115.3188468109, 68479.65760171067, 68620.6568967152, 8038.316743076904, 8749.562521873753, 8770.605322760619, 8837.337199709918, 9005.279577633642, 39778.40332395074, 40012.0, 40296.0, 40444.1911161781, 41683.58316416797, 33990.15024624305, 34685.65314346824, 35061.47407788834, 35450.468242976895, 37215.25569488541, 10954.671359859218, 11019.944900275448, 11348.716282093013, 11382.54469821198, 11551.942240289081, 12145.332006739714, 12566.926457134836, 12768.936155319165, 13405.463781448632, 13615.659608509866, 11395.829062564235, 11856.881431185922, 11920.940395297968, 12067.939660301643, 12077.335746534025, 11644.825327620261, 12214.239706683913, 12227.266364018187, 12290.262584244974, 12411.083395402255, 11042.613508527164, 12452.003839692985, 12452.439640216031, 12476.812847807472, 12501.0, 9457.43255404678, 9523.190528804853, 9982.201423886218, 10092.94953525257, 10195.184385249015, 9781.755456113655, 10136.061544290944, 10160.847587286344, 10219.540120694735, 10322.432266225129], "value": 6444.700182001094, "unit": "score"}], "name": "dromaeo_css", "value": 6276.189031292157, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 116.0, 114.0, 116.0, 116.0, 115.0, 115.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 136.0, 177.0, 133.0, 136.0, 127.0, 130.0, 178.0, 129.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 163.0, 162.0, 163.0, 162.0, 163.0, 164.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 85.0, 107.0, 78.0, 79.0, 79.0, 79.0, 104.0, 79.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 84.0, 86.0, 83.0, 105.0, 84.0, 85.0, 115.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 68.0, 68.0, 68.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 70.0, 69.0, 70.0, 68.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 92.0, 87.0, 85.0, 84.0, 87.0, 83.0, 92.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 142.0, 140.0, 139.0, 141.0, 139.0, 154.0, 140.0, 183.0, 155.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 182.0, 174.0, 176.0, 178.0, 177.0, 176.0, 181.0, 179.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 72.0, 72.0, 72.0, 74.0, 71.0, 75.0, 70.0, 70.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1566.8000000000002, "alertThreshold": 2.0}]} 12:21:33 INFO - Return code: 0 12:21:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:21:33 INFO - # TBPL SUCCESS # 12:21:33 INFO - Running post-action listener: _resource_record_post_action 12:21:33 INFO - [mozharness: 2016-10-14 19:21:33.805851Z] Finished run-tests step (success) 12:21:33 INFO - Running post-run listener: _resource_record_post_run 12:21:33 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393109504; Read time: 16; Write time: 269444 12:21:33 INFO - TinderboxPrint: CPU usage
13.1% 12:21:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:21:33 INFO - TinderboxPrint: I/O write bytes / time
393,109,504 / 269,444 12:21:33 INFO - TinderboxPrint: CPU idle
8,348.5 (86.9%) 12:21:33 INFO - TinderboxPrint: CPU user
1,207.4 (12.6%) 12:21:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:21:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100487168; Read time: 0; Write time: 59728 12:21:33 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292622336; Read time: 0; Write time: 209716 12:21:34 INFO - Running post-run listener: _upload_blobber_files 12:21:34 INFO - Blob upload gear active. 12:21:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:21:34 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 12:21:34 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'] 12:21:34 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 12:21:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:38 INFO - (blobuploader) - INFO - Done attempting. 12:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:38 INFO - (blobuploader) - INFO - Done attempting. 12:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:21:39 INFO - (blobuploader) - INFO - Done attempting. 12:21:39 INFO - (blobuploader) - INFO - Iteration through files over. 12:21:39 INFO - Return code: 0 12:21:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:21:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:21:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0e18e2683a1cc75a0fe88024901246ffc7d6ec10e947d5a4046eb0a835da06b551cb7afbca13ce9b6f5bcc7fb207ed997af1d60efd6823b2a54aa9319295066b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/950a2a3b2f8618781094d195e5868dcb6f151fa12fd95356da9f7b90ce54afb04f3648d23e94807e7f0c6adfcf1d56b0e5da583d0fa56997b8542886ae0b3013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ea39841eee3b6dc7a640b547113c96e8909790d9d9461a05582a12bec071f85bcac04fc98cb4538d0687f251a4822f5fa0f2d0f29235fe1d0ca46d567cacf3f"} 12:21:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:21:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:21:39 INFO - Contents: 12:21:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0e18e2683a1cc75a0fe88024901246ffc7d6ec10e947d5a4046eb0a835da06b551cb7afbca13ce9b6f5bcc7fb207ed997af1d60efd6823b2a54aa9319295066b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/950a2a3b2f8618781094d195e5868dcb6f151fa12fd95356da9f7b90ce54afb04f3648d23e94807e7f0c6adfcf1d56b0e5da583d0fa56997b8542886ae0b3013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ea39841eee3b6dc7a640b547113c96e8909790d9d9461a05582a12bec071f85bcac04fc98cb4538d0687f251a4822f5fa0f2d0f29235fe1d0ca46d567cacf3f"} 12:21:39 INFO - Running post-run listener: copy_logs_to_upload_dir 12:21:39 INFO - Copying logs to upload dir... 12:21:39 INFO - mkdir: /builds/slave/test/build/upload/logs 12:21:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.810643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-14 12:21:39.262839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 12:21:39.266367) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829 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/0e18e2683a1cc75a0fe88024901246ffc7d6ec10e947d5a4046eb0a835da06b551cb7afbca13ce9b6f5bcc7fb207ed997af1d60efd6823b2a54aa9319295066b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/950a2a3b2f8618781094d195e5868dcb6f151fa12fd95356da9f7b90ce54afb04f3648d23e94807e7f0c6adfcf1d56b0e5da583d0fa56997b8542886ae0b3013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ea39841eee3b6dc7a640b547113c96e8909790d9d9461a05582a12bec071f85bcac04fc98cb4538d0687f251a4822f5fa0f2d0f29235fe1d0ca46d567cacf3f"} build_url:https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/Ine1PjiGQe2a2ua2H5Q8IQ/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/0e18e2683a1cc75a0fe88024901246ffc7d6ec10e947d5a4046eb0a835da06b551cb7afbca13ce9b6f5bcc7fb207ed997af1d60efd6823b2a54aa9319295066b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/950a2a3b2f8618781094d195e5868dcb6f151fa12fd95356da9f7b90ce54afb04f3648d23e94807e7f0c6adfcf1d56b0e5da583d0fa56997b8542886ae0b3013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ea39841eee3b6dc7a640b547113c96e8909790d9d9461a05582a12bec071f85bcac04fc98cb4538d0687f251a4822f5fa0f2d0f29235fe1d0ca46d567cacf3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 12:21:39.292570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:21:39.292964) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476471648.71978-225870829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 12:21:39.378902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 12:21:39.379241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 12:21:39.379571) ========= ========= Total master_lag: 0.21 =========